builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-021 starttime: 1495719541.67 results: success (0) revision: 23a341e9b53d04f80ea6a66ced2d72cdc17afffb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-25 06:39:01.672783) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-25 06:39:01.673321) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-25 06:39:01.673661) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-25 06:39:01.712321) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 06:39:01.712603) ========= 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=df17445c3590ff7897617a0e00000225-1495708565.450963-2001006645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-25 06:39:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.6M=0s 2017-05-25 06:39:02 (39.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.323272 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 06:39:02.048990) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 06:39:02.052352) ========= 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=df17445c3590ff7897617a0e00000225-1495708565.450963-2001006645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015942 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 06:39:02.101879) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-25 06:39:02.105277) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 23a341e9b53d04f80ea6a66ced2d72cdc17afffb --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 23a341e9b53d04f80ea6a66ced2d72cdc17afffb --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=df17445c3590ff7897617a0e00000225-1495708565.450963-2001006645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-25 06:39:02,567 truncating revision to first 12 chars 2017-05-25 06:39:02,567 Setting DEBUG logging. 2017-05-25 06:39:02,567 attempt 1/10 2017-05-25 06:39:02,567 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/23a341e9b53d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-25 06:39:03,997 unpacking tar archive at: mozilla-central-23a341e9b53d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.837217 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-25 06:39:03.955148) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-25 06:39:03.955486) ========= script_repo_revision: 23a341e9b53d04f80ea6a66ced2d72cdc17afffb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-25 06:39:03.955922) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-25 06:39:03.959227) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-25 06:39:03.969044) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 54 secs) (at 2017-05-25 06:39:03.969365) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1495708565.450963-2001006645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:39:04 INFO - MultiFileLogger online at 20170525 06:39:04 in /builds/slave/test 06:39:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 06:39:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:39:04 INFO - {'append_to_log': False, 06:39:04 INFO - 'base_work_dir': '/builds/slave/test', 06:39:04 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:39:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:39:04 INFO - 'branch': 'Firefox-Non-PGO', 06:39:04 INFO - 'buildbot_json_path': 'buildprops.json', 06:39:04 INFO - 'config_files': ('talos/linux_config.py',), 06:39:04 INFO - 'default_actions': ('clobber', 06:39:04 INFO - 'read-buildbot-config', 06:39:04 INFO - 'download-and-extract', 06:39:04 INFO - 'populate-webroot', 06:39:04 INFO - 'create-virtualenv', 06:39:04 INFO - 'install', 06:39:04 INFO - 'run-tests'), 06:39:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:39:04 INFO - 'download_minidump_stackwalk': True, 06:39:04 INFO - 'download_symbols': 'ondemand', 06:39:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:39:04 INFO - 'tooltool.py': '/tools/tooltool.py', 06:39:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:39:04 INFO - '/tools/misc-python/virtualenv.py')}, 06:39:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:39:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:39:04 INFO - 'gecko_profile': False, 06:39:04 INFO - 'gecko_profile_interval': 0, 06:39:04 INFO - 'installer_path': 'installer.exe', 06:39:04 INFO - 'log_level': 'info', 06:39:04 INFO - 'log_name': 'talos', 06:39:04 INFO - 'log_to_console': True, 06:39:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:39:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:39:04 INFO - 'opt_config_files': (), 06:39:04 INFO - 'pip_index': False, 06:39:04 INFO - 'suite': 'dromaeojs-e10s', 06:39:04 INFO - 'system_bits': '32', 06:39:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:39:04 INFO - 'title': 'talos-linux64-ix-021', 06:39:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:39:04 INFO - 'use_talos_json': True, 06:39:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:39:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:39:04 INFO - 'work_dir': 'build'} 06:39:04 INFO - [mozharness: 2017-05-25 13:39:04.529535Z] Running clobber step. 06:39:04 INFO - Running pre-action listener: _resource_record_pre_action 06:39:04 INFO - Running main action method: clobber 06:39:04 INFO - rmtree: /builds/slave/test/build 06:39:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:39:06 INFO - Running post-action listener: _resource_record_post_action 06:39:06 INFO - [mozharness: 2017-05-25 13:39:06.061519Z] Finished clobber step (success) 06:39:06 INFO - [mozharness: 2017-05-25 13:39:06.061616Z] Running read-buildbot-config step. 06:39:06 INFO - Running pre-action listener: _resource_record_pre_action 06:39:06 INFO - Running main action method: read_buildbot_config 06:39:06 INFO - Using buildbot properties: 06:39:06 INFO - { 06:39:06 INFO - "project": "", 06:39:06 INFO - "product": "firefox", 06:39:06 INFO - "who": "Callek@gmail.com", 06:39:06 INFO - "installer_path": "public/build/target.tar.bz2", 06:39:06 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:39:06 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 06:39:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 06:39:06 INFO - "stage_platform": "linux64", 06:39:06 INFO - "basedir": "/builds/slave/test", 06:39:06 INFO - "buildnumber": 632, 06:39:06 INFO - "platform": "ubuntu64_hw", 06:39:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:39:06 INFO - "slavebuilddir": "test", 06:39:06 INFO - "taskId": "OLfCjXgbTVWjlYVUNKGdxw", 06:39:06 INFO - "branch": "mozilla-central", 06:39:06 INFO - "script_repo_revision": "production", 06:39:06 INFO - "revision": "23a341e9b53d04f80ea6a66ced2d72cdc17afffb", 06:39:06 INFO - "slavename": "talos-linux64-ix-021", 06:39:06 INFO - "repo_path": "mozilla-central" 06:39:06 INFO - } 06:39:06 INFO - Finding installer, test and symbols from parent task. 06:39:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OLfCjXgbTVWjlYVUNKGdxw'}, attempt #1 06:39:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OLfCjXgbTVWjlYVUNKGdxw'}, attempt #1 06:39:07 INFO - Task dependencies: R0ZoKBpfT0uGsv9GuTE9YQ 06:39:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R0ZoKBpfT0uGsv9GuTE9YQ'}, attempt #1 06:39:07 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/R0ZoKBpfT0uGsv9GuTE9YQ/artifacts/public/build/target.tar.bz2 06:39:07 INFO - Set test_url: https://queue.taskcluster.net/v1/task/R0ZoKBpfT0uGsv9GuTE9YQ/artifacts/public/build/test_packages.json 06:39:07 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/R0ZoKBpfT0uGsv9GuTE9YQ/artifacts/public/build/target.crashreporter-symbols.zip 06:39:07 INFO - Running post-action listener: _resource_record_post_action 06:39:07 INFO - [mozharness: 2017-05-25 13:39:07.533034Z] Finished read-buildbot-config step (success) 06:39:07 INFO - [mozharness: 2017-05-25 13:39:07.533404Z] Running download-and-extract step. 06:39:07 INFO - Running pre-action listener: _resource_record_pre_action 06:39:07 INFO - Running main action method: download_and_extract 06:39:07 INFO - mkdir: /builds/slave/test/build/tests 06:39:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:39:07 INFO - trying https://queue.taskcluster.net/v1/task/R0ZoKBpfT0uGsv9GuTE9YQ/artifacts/public/build/target.test_packages.json 06:39:07 INFO - Downloading https://queue.taskcluster.net/v1/task/R0ZoKBpfT0uGsv9GuTE9YQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:39:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R0ZoKBpfT0uGsv9GuTE9YQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:39:08 INFO - Downloaded 986 bytes. 06:39:08 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:39:08 INFO - Using the following test package requirements: 06:39:08 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:39:08 INFO - u'common': [u'target.common.tests.zip'], 06:39:08 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:39:08 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:39:08 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:39:08 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:39:08 INFO - u'mozbase': [u'target.common.tests.zip'], 06:39:08 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:39:08 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:39:08 INFO - u'web-platform': [u'target.common.tests.zip', 06:39:08 INFO - u'target.web-platform.tests.zip'], 06:39:08 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:39:08 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:39:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R0ZoKBpfT0uGsv9GuTE9YQ/artifacts/public/build/target.common.tests.zip 06:39:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R0ZoKBpfT0uGsv9GuTE9YQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:39:08 INFO - Fetch https://queue.taskcluster.net/v1/task/R0ZoKBpfT0uGsv9GuTE9YQ/artifacts/public/build/target.common.tests.zip into memory 06:39:09 INFO - Content-Length response header: 63524846 06:39:09 INFO - Bytes received: 63524846 06:39:20 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:39:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R0ZoKBpfT0uGsv9GuTE9YQ/artifacts/public/build/target.common.tests.zip 06:39:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R0ZoKBpfT0uGsv9GuTE9YQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:39:20 INFO - Fetch https://queue.taskcluster.net/v1/task/R0ZoKBpfT0uGsv9GuTE9YQ/artifacts/public/build/target.common.tests.zip into memory 06:39:22 INFO - Content-Length response header: 63524846 06:39:22 INFO - Bytes received: 63524846 06:39:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R0ZoKBpfT0uGsv9GuTE9YQ/artifacts/public/build/target.talos.tests.zip 06:39:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R0ZoKBpfT0uGsv9GuTE9YQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:39:33 INFO - Fetch https://queue.taskcluster.net/v1/task/R0ZoKBpfT0uGsv9GuTE9YQ/artifacts/public/build/target.talos.tests.zip into memory 06:39:34 INFO - Content-Length response header: 14411859 06:39:34 INFO - Bytes received: 14411859 06:39:34 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')]} 06:39:34 INFO - trying https://queue.taskcluster.net/v1/task/R0ZoKBpfT0uGsv9GuTE9YQ/artifacts/public/build/target.tar.bz2 06:39:34 INFO - Downloading https://queue.taskcluster.net/v1/task/R0ZoKBpfT0uGsv9GuTE9YQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:39:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R0ZoKBpfT0uGsv9GuTE9YQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:39:35 INFO - Downloaded 54016575 bytes. 06:39:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R0ZoKBpfT0uGsv9GuTE9YQ/artifacts/public/build/target.tar.bz2 06:39:35 INFO - mkdir: /builds/slave/test/properties 06:39:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:39:35 INFO - Writing to file /builds/slave/test/properties/build_url 06:39:35 INFO - Contents: 06:39:35 INFO - build_url:https://queue.taskcluster.net/v1/task/R0ZoKBpfT0uGsv9GuTE9YQ/artifacts/public/build/target.tar.bz2 06:39:35 INFO - Running post-action listener: _resource_record_post_action 06:39:35 INFO - Running post-action listener: set_extra_try_arguments 06:39:35 INFO - [mozharness: 2017-05-25 13:39:35.962157Z] Finished download-and-extract step (success) 06:39:35 INFO - [mozharness: 2017-05-25 13:39:35.962255Z] Running populate-webroot step. 06:39:35 INFO - Running pre-action listener: _resource_record_pre_action 06:39:35 INFO - Running main action method: populate_webroot 06:39:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:39:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:39:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:39:35 INFO - '--tppagecycles', 06:39:35 INFO - '7'], 06:39:35 INFO - 'tests': ['tsvgm']}}, 06:39:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:39:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:39:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:39:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:39:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:39:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:39:35 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:39:35 INFO - 'talos_options': ['--disable-e10s'], 06:39:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:39:35 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:39:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:39:35 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:39:35 INFO - 'talos_options': ['--disable-e10s'], 06:39:35 INFO - 'tests': ['damp', 'tps']}, 06:39:35 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:39:35 INFO - 'tests': ['damp', 'tps']}, 06:39:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:39:35 INFO - 'tests': ['dromaeo_dom']}, 06:39:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:39:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:39:35 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 06:39:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 06:39:35 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 06:39:35 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 06:39:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:39:35 INFO - 'tests': ['a11yr', 06:39:35 INFO - 'ts_paint', 06:39:35 INFO - 'tpaint', 06:39:35 INFO - 'sessionrestore', 06:39:35 INFO - 'sessionrestore_no_auto_restore', 06:39:35 INFO - 'tabpaint']}, 06:39:35 INFO - 'other-e10s': {'tests': ['a11yr', 06:39:35 INFO - 'ts_paint', 06:39:35 INFO - 'tpaint', 06:39:35 INFO - 'sessionrestore', 06:39:35 INFO - 'sessionrestore_no_auto_restore', 06:39:35 INFO - 'tabpaint']}, 06:39:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:39:35 INFO - 'ts_paint', 06:39:35 INFO - 'tpaint', 06:39:35 INFO - 'sessionrestore', 06:39:35 INFO - 'sessionrestore_no_auto_restore', 06:39:35 INFO - 'tabpaint']}, 06:39:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:39:35 INFO - 'ts_paint', 06:39:35 INFO - 'tpaint', 06:39:35 INFO - 'sessionrestore', 06:39:35 INFO - 'sessionrestore_no_auto_restore', 06:39:35 INFO - 'tabpaint']}, 06:39:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:39:35 INFO - 'tests': ['a11yr', 06:39:35 INFO - 'ts_paint', 06:39:35 INFO - 'tpaint', 06:39:35 INFO - 'sessionrestore', 06:39:35 INFO - 'sessionrestore_no_auto_restore', 06:39:35 INFO - 'tabpaint']}, 06:39:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:39:35 INFO - 'tests': ['a11yr', 06:39:35 INFO - 'ts_paint', 06:39:35 INFO - 'tpaint', 06:39:35 INFO - 'sessionrestore', 06:39:35 INFO - 'sessionrestore_no_auto_restore', 06:39:35 INFO - 'tabpaint']}, 06:39:35 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 06:39:35 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 06:39:35 INFO - 'bloom_basic_ref']}, 06:39:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:39:35 INFO - 'tests': ['tsvgx', 06:39:35 INFO - 'tsvgr_opacity', 06:39:35 INFO - 'tart', 06:39:35 INFO - 'tscrollx', 06:39:35 INFO - 'cart', 06:39:35 INFO - 'tsvg_static']}, 06:39:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:39:35 INFO - 'tsvgr_opacity', 06:39:35 INFO - 'tart', 06:39:35 INFO - 'tscrollx', 06:39:35 INFO - 'cart', 06:39:35 INFO - 'tsvg_static']}, 06:39:35 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:39:35 INFO - 'talos_options': ['--disable-e10s'], 06:39:35 INFO - 'tests': ['tp5o']}, 06:39:35 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:39:35 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:39:35 INFO - 'talos_options': ['--disable-e10s', 06:39:35 INFO - '--xperf_path', 06:39:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:39:35 INFO - 'tests': ['tp5n']}, 06:39:35 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:39:35 INFO - 'talos_options': ['--xperf_path', 06:39:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:39:35 INFO - 'tests': ['tp5n']}}, 06:39:35 INFO - 'talos.zip': {'path': '', 06:39:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:39:35 INFO - Running post-action listener: _resource_record_post_action 06:39:35 INFO - [mozharness: 2017-05-25 13:39:35.976238Z] Finished populate-webroot step (success) 06:39:35 INFO - [mozharness: 2017-05-25 13:39:35.976326Z] Running create-virtualenv step. 06:39:35 INFO - Running pre-action listener: _resource_record_pre_action 06:39:35 INFO - Running main action method: create_virtualenv 06:39:35 INFO - Creating virtualenv /builds/slave/test/build/venv 06:39:35 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 06:39:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:39:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:39:36 INFO - Using real prefix '/usr' 06:39:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:39:36 INFO - Installing distribute.............................................................................................................................................................................................done. 06:39:38 INFO - Installing pip.................done. 06:39:38 INFO - Return code: 0 06:39:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:39:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:39:38 INFO - Reading from file tmpfile_stdout 06:39:38 INFO - Output received: 06:39:38 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) 06:39:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:39:38 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')]} 06:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:38 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')]} 06:39:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:38 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 0x27601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad35c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad07a0>, '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 0x2ad16a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad1b30>, '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': 'df17445c3590ff7897617a0e00000225-1495708565.450963-2001006645', '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 06:39:38 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 06:39:38 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 06:39:38 INFO - Using env: {'DISPLAY': ':0', 06:39:38 INFO - 'HOME': '/home/cltbld', 06:39:38 INFO - 'LANG': 'en_US.UTF-8', 06:39:38 INFO - 'LANGUAGE': 'en_US:en', 06:39:38 INFO - 'LOGNAME': 'cltbld', 06:39:38 INFO - 'MAIL': '/var/mail/cltbld', 06:39:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:38 INFO - 'MOZ_NO_REMOTE': '1', 06:39:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:38 INFO - 'NO_EM_RESTART': '1', 06:39:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:38 INFO - 'PWD': '/builds/slave/test', 06:39:38 INFO - 'SHELL': '/bin/bash', 06:39:38 INFO - 'SHLVL': '1', 06:39:38 INFO - 'TERM': 'linux', 06:39:38 INFO - 'TMOUT': '86400', 06:39:38 INFO - 'USER': 'cltbld', 06:39:38 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1495708565.450963-2001006645', 06:39:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:38 INFO - '_': '/tools/buildbot/bin/python'} 06:39:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:39 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 06:39:39 INFO - Cleaning up... 06:39:39 INFO - Return code: 0 06:39:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:39:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:39:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:39:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x27601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad35c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad07a0>, '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 0x2ad16a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad1b30>, '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': 'df17445c3590ff7897617a0e00000225-1495708565.450963-2001006645', '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 06:39:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:39:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:39:39 INFO - Using env: {'DISPLAY': ':0', 06:39:39 INFO - 'HOME': '/home/cltbld', 06:39:39 INFO - 'LANG': 'en_US.UTF-8', 06:39:39 INFO - 'LANGUAGE': 'en_US:en', 06:39:39 INFO - 'LOGNAME': 'cltbld', 06:39:39 INFO - 'MAIL': '/var/mail/cltbld', 06:39:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:39 INFO - 'MOZ_NO_REMOTE': '1', 06:39:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:39 INFO - 'NO_EM_RESTART': '1', 06:39:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:39 INFO - 'PWD': '/builds/slave/test', 06:39:39 INFO - 'SHELL': '/bin/bash', 06:39:39 INFO - 'SHLVL': '1', 06:39:39 INFO - 'TERM': 'linux', 06:39:39 INFO - 'TMOUT': '86400', 06:39:39 INFO - 'USER': 'cltbld', 06:39:39 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1495708565.450963-2001006645', 06:39:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:39 INFO - '_': '/tools/buildbot/bin/python'} 06:39:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:39 INFO - Downloading/unpacking psutil>=3.1.1 06:39:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:39:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:39:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:39:40 INFO - Installing collected packages: psutil 06:39:40 INFO - Running setup.py install for psutil 06:39:40 INFO - building 'psutil._psutil_linux' extension 06:39:40 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 06:39:40 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 06:39:40 INFO - building 'psutil._psutil_posix' extension 06:39:40 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 06:39:40 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 06:39:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:39:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:39:40 INFO - Successfully installed psutil 06:39:40 INFO - Cleaning up... 06:39:40 INFO - Return code: 0 06:39:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:39:40 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')]} 06:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:40 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')]} 06:39:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:40 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 0x27601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad35c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad07a0>, '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 0x2ad16a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad1b30>, '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': 'df17445c3590ff7897617a0e00000225-1495708565.450963-2001006645', '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 06:39:40 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 06:39:40 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 06:39:40 INFO - Using env: {'DISPLAY': ':0', 06:39:40 INFO - 'HOME': '/home/cltbld', 06:39:40 INFO - 'LANG': 'en_US.UTF-8', 06:39:40 INFO - 'LANGUAGE': 'en_US:en', 06:39:40 INFO - 'LOGNAME': 'cltbld', 06:39:40 INFO - 'MAIL': '/var/mail/cltbld', 06:39:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:40 INFO - 'MOZ_NO_REMOTE': '1', 06:39:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:40 INFO - 'NO_EM_RESTART': '1', 06:39:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:40 INFO - 'PWD': '/builds/slave/test', 06:39:40 INFO - 'SHELL': '/bin/bash', 06:39:40 INFO - 'SHLVL': '1', 06:39:40 INFO - 'TERM': 'linux', 06:39:40 INFO - 'TMOUT': '86400', 06:39:40 INFO - 'USER': 'cltbld', 06:39:40 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1495708565.450963-2001006645', 06:39:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:40 INFO - '_': '/tools/buildbot/bin/python'} 06:39:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:39: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 06:39: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 06:39: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 06:39: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 06:39:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:39:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:39:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:39:42 INFO - Installing collected packages: mozsystemmonitor 06:39:42 INFO - Running setup.py install for mozsystemmonitor 06:39:42 INFO - Successfully installed mozsystemmonitor 06:39:42 INFO - Cleaning up... 06:39:42 INFO - Return code: 0 06:39:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:39:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:39:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:39:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad35c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad07a0>, '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 0x2ad16a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad1b30>, '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': 'df17445c3590ff7897617a0e00000225-1495708565.450963-2001006645', '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 06:39:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:39:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:39:42 INFO - Using env: {'DISPLAY': ':0', 06:39:42 INFO - 'HOME': '/home/cltbld', 06:39:42 INFO - 'LANG': 'en_US.UTF-8', 06:39:42 INFO - 'LANGUAGE': 'en_US:en', 06:39:42 INFO - 'LOGNAME': 'cltbld', 06:39:42 INFO - 'MAIL': '/var/mail/cltbld', 06:39:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:42 INFO - 'MOZ_NO_REMOTE': '1', 06:39:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:42 INFO - 'NO_EM_RESTART': '1', 06:39:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:42 INFO - 'PWD': '/builds/slave/test', 06:39:42 INFO - 'SHELL': '/bin/bash', 06:39:42 INFO - 'SHLVL': '1', 06:39:42 INFO - 'TERM': 'linux', 06:39:42 INFO - 'TMOUT': '86400', 06:39:42 INFO - 'USER': 'cltbld', 06:39:42 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1495708565.450963-2001006645', 06:39:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:42 INFO - '_': '/tools/buildbot/bin/python'} 06:39:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:42 INFO - Downloading/unpacking jsonschema==2.5.1 06:39:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:39:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:39:43 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 06:39:43 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 06:39:43 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 06:39:43 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 06:39:44 INFO - Downloading functools32-3.2.3-2.tar.gz 06:39:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:39:44 INFO - warning: no files found matching '*.txt' 06:39:44 INFO - no previously-included directories found matching 'build' 06:39:44 INFO - no previously-included directories found matching 'dist' 06:39:44 INFO - no previously-included directories found matching '.git*' 06:39:44 INFO - Installing collected packages: jsonschema, functools32 06:39:44 INFO - Running setup.py install for functools32 06:39:44 INFO - warning: no files found matching '*.txt' 06:39:44 INFO - no previously-included directories found matching 'build' 06:39:44 INFO - no previously-included directories found matching 'dist' 06:39:44 INFO - no previously-included directories found matching '.git*' 06:39:44 INFO - Successfully installed jsonschema functools32 06:39:44 INFO - Cleaning up... 06:39:44 INFO - Return code: 0 06:39:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:39:44 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')]} 06:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:44 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')]} 06:39:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:44 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 0x27601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad35c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad07a0>, '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 0x2ad16a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad1b30>, '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': 'df17445c3590ff7897617a0e00000225-1495708565.450963-2001006645', '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 06:39:44 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 06:39:44 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 06:39:44 INFO - Using env: {'DISPLAY': ':0', 06:39:44 INFO - 'HOME': '/home/cltbld', 06:39:44 INFO - 'LANG': 'en_US.UTF-8', 06:39:44 INFO - 'LANGUAGE': 'en_US:en', 06:39:44 INFO - 'LOGNAME': 'cltbld', 06:39:44 INFO - 'MAIL': '/var/mail/cltbld', 06:39:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:44 INFO - 'MOZ_NO_REMOTE': '1', 06:39:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:44 INFO - 'NO_EM_RESTART': '1', 06:39:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:44 INFO - 'PWD': '/builds/slave/test', 06:39:44 INFO - 'SHELL': '/bin/bash', 06:39:44 INFO - 'SHLVL': '1', 06:39:44 INFO - 'TERM': 'linux', 06:39:44 INFO - 'TMOUT': '86400', 06:39:44 INFO - 'USER': 'cltbld', 06:39:44 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1495708565.450963-2001006645', 06:39:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:44 INFO - '_': '/tools/buildbot/bin/python'} 06:39:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:39:44 INFO - Cleaning up... 06:39:44 INFO - Return code: 0 06:39:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:39:44 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')]} 06:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:44 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')]} 06:39:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:44 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 0x27601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad35c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad07a0>, '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 0x2ad16a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad1b30>, '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': 'df17445c3590ff7897617a0e00000225-1495708565.450963-2001006645', '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 06:39:44 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 06:39:44 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 06:39:44 INFO - Using env: {'DISPLAY': ':0', 06:39:44 INFO - 'HOME': '/home/cltbld', 06:39:44 INFO - 'LANG': 'en_US.UTF-8', 06:39:44 INFO - 'LANGUAGE': 'en_US:en', 06:39:44 INFO - 'LOGNAME': 'cltbld', 06:39:44 INFO - 'MAIL': '/var/mail/cltbld', 06:39:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:44 INFO - 'MOZ_NO_REMOTE': '1', 06:39:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:44 INFO - 'NO_EM_RESTART': '1', 06:39:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:44 INFO - 'PWD': '/builds/slave/test', 06:39:44 INFO - 'SHELL': '/bin/bash', 06:39:44 INFO - 'SHLVL': '1', 06:39:44 INFO - 'TERM': 'linux', 06:39:44 INFO - 'TMOUT': '86400', 06:39:44 INFO - 'USER': 'cltbld', 06:39:44 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1495708565.450963-2001006645', 06:39:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:44 INFO - '_': '/tools/buildbot/bin/python'} 06:39:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:44 INFO - Downloading/unpacking blobuploader==1.2.4 06:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:45 INFO - Downloading blobuploader-1.2.4.tar.gz 06:39:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:39:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:39:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:39:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:39:46 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 06:39:46 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 06:39:46 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 06:39:46 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 06:39:46 INFO - Downloading docopt-0.6.1.tar.gz 06:39:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:39:46 INFO - Installing collected packages: blobuploader, requests, docopt 06:39:46 INFO - Running setup.py install for blobuploader 06:39:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:39:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:39:46 INFO - Running setup.py install for requests 06:39:46 INFO - Running setup.py install for docopt 06:39:47 INFO - Successfully installed blobuploader requests docopt 06:39:47 INFO - Cleaning up... 06:39:47 INFO - Return code: 0 06:39:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:39:47 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')]} 06:39:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:47 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')]} 06:39:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:47 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 0x27601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad35c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad07a0>, '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 0x2ad16a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad1b30>, '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': 'df17445c3590ff7897617a0e00000225-1495708565.450963-2001006645', '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 06:39:47 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 06:39:47 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 06:39:47 INFO - Using env: {'DISPLAY': ':0', 06:39:47 INFO - 'HOME': '/home/cltbld', 06:39:47 INFO - 'LANG': 'en_US.UTF-8', 06:39:47 INFO - 'LANGUAGE': 'en_US:en', 06:39:47 INFO - 'LOGNAME': 'cltbld', 06:39:47 INFO - 'MAIL': '/var/mail/cltbld', 06:39:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:47 INFO - 'MOZ_NO_REMOTE': '1', 06:39:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:47 INFO - 'NO_EM_RESTART': '1', 06:39:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:47 INFO - 'PWD': '/builds/slave/test', 06:39:47 INFO - 'SHELL': '/bin/bash', 06:39:47 INFO - 'SHLVL': '1', 06:39:47 INFO - 'TERM': 'linux', 06:39:47 INFO - 'TMOUT': '86400', 06:39:47 INFO - 'USER': 'cltbld', 06:39:47 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1495708565.450963-2001006645', 06:39:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:47 INFO - '_': '/tools/buildbot/bin/python'} 06:39:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:39:47 INFO - Running setup.py (path:/tmp/pip-6bpWxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:39:47 INFO - Running setup.py (path:/tmp/pip-Nw1tvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:39:47 INFO - Running setup.py (path:/tmp/pip-CWRQit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:39:47 INFO - Running setup.py (path:/tmp/pip-lW_r3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:39:47 INFO - Running setup.py (path:/tmp/pip-I5IM70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:39:47 INFO - Running setup.py (path:/tmp/pip-qKzBrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:39:47 INFO - Running setup.py (path:/tmp/pip-kvD8AU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:39:47 INFO - Running setup.py (path:/tmp/pip-NE9G6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:39:47 INFO - Running setup.py (path:/tmp/pip-9Ck5VJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:39:47 INFO - Running setup.py (path:/tmp/pip-c_2oir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:39:47 INFO - Running setup.py (path:/tmp/pip-FW8Poe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:39:48 INFO - Running setup.py (path:/tmp/pip-IHGjkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:39:48 INFO - Running setup.py (path:/tmp/pip-6UP5a5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:39:48 INFO - Running setup.py (path:/tmp/pip-GdhP4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:39:48 INFO - Running setup.py (path:/tmp/pip-l6Zjay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:39:48 INFO - Running setup.py (path:/tmp/pip-yNRvfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:39:48 INFO - Running setup.py (path:/tmp/pip-LRgf_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:39:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:39:48 INFO - Running setup.py install for manifestparser 06:39:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:39:48 INFO - Running setup.py install for mozcrash 06:39:48 INFO - Running setup.py install for mozdebug 06:39:48 INFO - Running setup.py install for mozdevice 06:39:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:39:48 INFO - Running setup.py install for mozfile 06:39:48 INFO - Running setup.py install for mozhttpd 06:39:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:39:49 INFO - Running setup.py install for mozinfo 06:39:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:39:49 INFO - Running setup.py install for mozInstall 06:39:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:39:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:39:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:39:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:39:49 INFO - Running setup.py install for mozleak 06:39:49 INFO - Running setup.py install for mozlog 06:39:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:39:49 INFO - Running setup.py install for moznetwork 06:39:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:39:49 INFO - Running setup.py install for mozprocess 06:39:49 INFO - Running setup.py install for mozprofile 06:39:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:39:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:39:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:39:49 INFO - Running setup.py install for mozrunner 06:39:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:39:49 INFO - Running setup.py install for mozscreenshot 06:39:50 INFO - Running setup.py install for moztest 06:39:50 INFO - Running setup.py install for mozversion 06:39:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:39:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:39:50 INFO - Cleaning up... 06:39:50 INFO - Return code: 0 06:39:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:39:50 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')]} 06:39:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:50 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')]} 06:39:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:50 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 0x27601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad35c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad07a0>, '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 0x2ad16a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad1b30>, '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': 'df17445c3590ff7897617a0e00000225-1495708565.450963-2001006645', '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 06:39:50 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 06:39:50 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 06:39:50 INFO - Using env: {'DISPLAY': ':0', 06:39:50 INFO - 'HOME': '/home/cltbld', 06:39:50 INFO - 'LANG': 'en_US.UTF-8', 06:39:50 INFO - 'LANGUAGE': 'en_US:en', 06:39:50 INFO - 'LOGNAME': 'cltbld', 06:39:50 INFO - 'MAIL': '/var/mail/cltbld', 06:39:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:50 INFO - 'MOZ_NO_REMOTE': '1', 06:39:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:50 INFO - 'NO_EM_RESTART': '1', 06:39:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:50 INFO - 'PWD': '/builds/slave/test', 06:39:50 INFO - 'SHELL': '/bin/bash', 06:39:50 INFO - 'SHLVL': '1', 06:39:50 INFO - 'TERM': 'linux', 06:39:50 INFO - 'TMOUT': '86400', 06:39:50 INFO - 'USER': 'cltbld', 06:39:50 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1495708565.450963-2001006645', 06:39:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:50 INFO - '_': '/tools/buildbot/bin/python'} 06:39:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:39:50 INFO - Running setup.py (path:/tmp/pip-ytUJCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:39:50 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)) 06:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:39:50 INFO - Running setup.py (path:/tmp/pip-pYoRW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:39:50 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)) 06:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:39:50 INFO - Running setup.py (path:/tmp/pip-BS7R_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:39:50 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)) 06:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:39:50 INFO - Running setup.py (path:/tmp/pip-J59oGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:39:50 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)) 06:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:39:50 INFO - Running setup.py (path:/tmp/pip-hVD4kR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:39:50 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)) 06:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:39:50 INFO - Running setup.py (path:/tmp/pip-OFDdOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:39:50 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)) 06:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:39:50 INFO - Running setup.py (path:/tmp/pip-Z4woiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:39:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:39:51 INFO - Running setup.py (path:/tmp/pip-WzgFUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:39:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:39:51 INFO - Running setup.py (path:/tmp/pip-AwGleb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:39:51 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)) 06:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:39:51 INFO - Running setup.py (path:/tmp/pip-fDh23E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:39:51 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)) 06:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:39:51 INFO - Running setup.py (path:/tmp/pip-roEkTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:39:51 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)) 06:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:39:51 INFO - Running setup.py (path:/tmp/pip-Vb8g8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:39:51 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)) 06:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:39:51 INFO - Running setup.py (path:/tmp/pip-JTYY_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:39:51 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)) 06:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:39:51 INFO - Running setup.py (path:/tmp/pip-zHwVAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:39:51 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)) 06:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:39:51 INFO - Running setup.py (path:/tmp/pip-OU_xLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:39:51 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)) 06:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:39:51 INFO - Running setup.py (path:/tmp/pip-vHhe38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:39:51 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)) 06:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:39:51 INFO - Running setup.py (path:/tmp/pip-UjA7Om-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:39:51 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)) 06:39:51 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)) 06:39:51 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)) 06:39:51 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)) 06:39:51 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)) 06:39:51 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)) 06:39:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:52 INFO - Downloading blessings-1.6.tar.gz 06:39:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:39:52 INFO - Installing collected packages: blessings 06:39:52 INFO - Running setup.py install for blessings 06:39:52 INFO - Successfully installed blessings 06:39:52 INFO - Cleaning up... 06:39:53 INFO - Return code: 0 06:39:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:39:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:39:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:39:53 INFO - Reading from file tmpfile_stdout 06:39:53 INFO - Current package versions: 06:39:53 INFO - argparse == 1.2.1 06:39:53 INFO - blessings == 1.6 06:39:53 INFO - blobuploader == 1.2.4 06:39:53 INFO - docopt == 0.6.1 06:39:53 INFO - functools32 == 3.2.3-2 06:39:53 INFO - jsonschema == 2.5.1 06:39:53 INFO - manifestparser == 1.1 06:39:53 INFO - mozInstall == 1.12 06:39:53 INFO - mozcrash == 1.0 06:39:53 INFO - mozdebug == 0.1 06:39:53 INFO - mozdevice == 0.51 06:39:53 INFO - mozfile == 1.2 06:39:53 INFO - mozhttpd == 0.7 06:39:53 INFO - mozinfo == 0.9 06:39:53 INFO - mozleak == 0.1 06:39:53 INFO - mozlog == 3.4 06:39:53 INFO - moznetwork == 0.27 06:39:53 INFO - mozprocess == 0.25 06:39:53 INFO - mozprofile == 0.28 06:39:53 INFO - mozrunner == 6.13 06:39:53 INFO - mozscreenshot == 0.1 06:39:53 INFO - mozsystemmonitor == 0.3 06:39:53 INFO - moztest == 0.8 06:39:53 INFO - mozversion == 1.4 06:39:53 INFO - psutil == 3.1.1 06:39:53 INFO - requests == 1.2.3 06:39:53 INFO - wsgiref == 0.1.2 06:39:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:39:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:39:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:53 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 0x27601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad35c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad07a0>, '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 0x2ad16a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad1b30>, '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': 'df17445c3590ff7897617a0e00000225-1495708565.450963-2001006645', '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 06:39:53 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 06:39:53 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 06:39:53 INFO - Using env: {'DISPLAY': ':0', 06:39:53 INFO - 'HOME': '/home/cltbld', 06:39:53 INFO - 'LANG': 'en_US.UTF-8', 06:39:53 INFO - 'LANGUAGE': 'en_US:en', 06:39:53 INFO - 'LOGNAME': 'cltbld', 06:39:53 INFO - 'MAIL': '/var/mail/cltbld', 06:39:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:53 INFO - 'MOZ_NO_REMOTE': '1', 06:39:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:53 INFO - 'NO_EM_RESTART': '1', 06:39:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:53 INFO - 'PWD': '/builds/slave/test', 06:39:53 INFO - 'SHELL': '/bin/bash', 06:39:53 INFO - 'SHLVL': '1', 06:39:53 INFO - 'TERM': 'linux', 06:39:53 INFO - 'TMOUT': '86400', 06:39:53 INFO - 'USER': 'cltbld', 06:39:53 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1495708565.450963-2001006645', 06:39:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:53 INFO - '_': '/tools/buildbot/bin/python'} 06:39:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:53 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)) 06:39:53 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)) 06:39:53 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)) 06:39:53 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)) 06:39:53 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)) 06:39:53 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)) 06:39:53 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)) 06:39:53 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)) 06:39:53 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)) 06:39:53 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 06:39:53 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 06:39:53 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 06:39:53 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 06:39:53 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 06:39:55 INFO - Downloading marionette_driver-1.4.0.tar.gz 06:39:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 06:39:55 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)) 06:39:55 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)) 06:39:55 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)) 06:39:55 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)) 06:39:55 INFO - Installing collected packages: marionette-driver 06:39:55 INFO - Running setup.py install for marionette-driver 06:39:55 INFO - Successfully installed marionette-driver 06:39:55 INFO - Cleaning up... 06:39:55 INFO - Return code: 0 06:39:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:39:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad35c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad07a0>, '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 0x2ad16a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad1b30>, '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': 'df17445c3590ff7897617a0e00000225-1495708565.450963-2001006645', '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 06:39:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:39:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:39:55 INFO - Using env: {'DISPLAY': ':0', 06:39:55 INFO - 'HOME': '/home/cltbld', 06:39:55 INFO - 'LANG': 'en_US.UTF-8', 06:39:55 INFO - 'LANGUAGE': 'en_US:en', 06:39:55 INFO - 'LOGNAME': 'cltbld', 06:39:55 INFO - 'MAIL': '/var/mail/cltbld', 06:39:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:55 INFO - 'MOZ_NO_REMOTE': '1', 06:39:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:55 INFO - 'NO_EM_RESTART': '1', 06:39:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:55 INFO - 'PWD': '/builds/slave/test', 06:39:55 INFO - 'SHELL': '/bin/bash', 06:39:55 INFO - 'SHLVL': '1', 06:39:55 INFO - 'TERM': 'linux', 06:39:55 INFO - 'TMOUT': '86400', 06:39:55 INFO - 'USER': 'cltbld', 06:39:55 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1495708565.450963-2001006645', 06:39:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:55 INFO - '_': '/tools/buildbot/bin/python'} 06:39:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:39:56 INFO - Cleaning up... 06:39:56 INFO - Return code: 0 06:39:56 INFO - Running post-action listener: _resource_record_post_action 06:39:56 INFO - Running post-action listener: _start_resource_monitoring 06:39:56 INFO - Starting resource monitoring. 06:39:56 INFO - [mozharness: 2017-05-25 13:39:56.046002Z] Finished create-virtualenv step (success) 06:39:56 INFO - [mozharness: 2017-05-25 13:39:56.046511Z] Running install step. 06:39:56 INFO - Running pre-action listener: _resource_record_pre_action 06:39:56 INFO - Running main action method: install 06:39:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:39:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:39:56 INFO - Reading from file tmpfile_stdout 06:39:56 INFO - Detecting whether we're running mozinstall >=1.0... 06:39:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:39:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:39:56 INFO - Reading from file tmpfile_stdout 06:39:56 INFO - Output received: 06:39:56 INFO - Usage: mozinstall [options] installer 06:39:56 INFO - Options: 06:39:56 INFO - -h, --help show this help message and exit 06:39:56 INFO - -d DEST, --destination=DEST 06:39:56 INFO - Directory to install application into. [default: 06:39:56 INFO - "/builds/slave/test"] 06:39:56 INFO - --app=APP Application being installed. [default: firefox] 06:39:56 INFO - mkdir: /builds/slave/test/build/application 06:39:56 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'] 06:39:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:40:11 INFO - Reading from file tmpfile_stdout 06:40:11 INFO - Output received: 06:40:11 INFO - /builds/slave/test/build/application/firefox/firefox 06:40:11 INFO - Running post-action listener: _resource_record_post_action 06:40:11 INFO - [mozharness: 2017-05-25 13:40:11.942656Z] Finished install step (success) 06:40:11 INFO - [mozharness: 2017-05-25 13:40:11.942934Z] Running run-tests step. 06:40:11 INFO - Running pre-action listener: _resource_record_pre_action 06:40:11 INFO - Running main action method: run_tests 06:40:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:40:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:40:11 INFO - Python 2.7.3 06:40:11 INFO - Return code: 0 06:40:11 INFO - grabbing minidump binary from tooltool 06:40:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:40:11 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad07a0>, '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 0x2ad16a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad1b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:40:11 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:40:11 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:40:11 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:40:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:40:12 INFO - Return code: 0 06:40:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:40:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:40:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:40:12 INFO - ENV: RUST_BACKTRACE is now 1 06:40:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:40:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:40:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R0ZoKBpfT0uGsv9GuTE9YQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 06:40:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/R0ZoKBpfT0uGsv9GuTE9YQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 06:40:12 INFO - Using env: {'DISPLAY': ':0', 06:40:12 INFO - 'HOME': '/home/cltbld', 06:40:12 INFO - 'LANG': 'en_US.UTF-8', 06:40:12 INFO - 'LANGUAGE': 'en_US:en', 06:40:12 INFO - 'LOGNAME': 'cltbld', 06:40:12 INFO - 'MAIL': '/var/mail/cltbld', 06:40:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:40:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:40:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:12 INFO - 'MOZ_NO_REMOTE': '1', 06:40:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:40:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:12 INFO - 'NO_EM_RESTART': '1', 06:40:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:12 INFO - 'PWD': '/builds/slave/test', 06:40:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:40:12 INFO - 'RUST_BACKTRACE': '1', 06:40:12 INFO - 'SHELL': '/bin/bash', 06:40:12 INFO - 'SHLVL': '1', 06:40:12 INFO - 'TERM': 'linux', 06:40:12 INFO - 'TMOUT': '86400', 06:40:12 INFO - 'USER': 'cltbld', 06:40:12 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1495708565.450963-2001006645', 06:40:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:12 INFO - '_': '/tools/buildbot/bin/python'} 06:40:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R0ZoKBpfT0uGsv9GuTE9YQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 06:40:12 INFO - mozversion application_buildid: 20170525130908 06:40:12 INFO - mozversion application_changeset: 23a341e9b53d04f80ea6a66ced2d72cdc17afffb 06:40:12 INFO - mozversion application_display_name: Nightly 06:40:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:40:12 INFO - mozversion application_name: Firefox 06:40:12 INFO - mozversion application_remotingname: firefox 06:40:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:40:12 INFO - mozversion application_vendor: Mozilla 06:40:12 INFO - mozversion application_version: 55.0a1 06:40:12 INFO - mozversion platform_buildid: 20170525130908 06:40:12 INFO - mozversion platform_changeset: 23a341e9b53d04f80ea6a66ced2d72cdc17afffb 06:40:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:40:12 INFO - mozversion platform_version: 55.0a1 06:40:12 INFO - using testdate: 1495719612 06:40:12 INFO - actual date: 1495719612 06:40:12 INFO - starting webserver on 'localhost:43716' 06:40:12 INFO - SUITE-START | Running 2 tests 06:40:12 INFO - TEST-START | dromaeo_css 06:40:12 INFO - operating with platform_type : linux_ 06:40:12 INFO - Initialising browser for dromaeo_css test... 06:40:12 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43716/getInfo.html -profile /tmp/tmp2IjA5b/profile 06:40:12 INFO - TEST-INFO | started process 7883 (/builds/slave/test/build/application/firefox/firefox http://localhost:43716/getInfo.html) 06:40:47 INFO - TEST-INFO | 7883: killed by SIGTERM 06:40:47 INFO - Browser initialized. 06:40:47 INFO - Running cycle 1/1 for dromaeo_css test... 06:40:47 INFO - TEST-INFO | started process 8081 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2IjA5b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:40:59 INFO - PID 8081 | RSS: Main: 173543424 06:40:59 INFO - PID 8081 | 06:44:04 INFO - PID 8081 | Cycle 1(1): loaded http://localhost:43716/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43716/tests/dromaeo/cssquery-ext.html) 06:44:05 INFO - PID 8081 | RSS: Main: 172470272 06:44:05 INFO - PID 8081 | 06:47:07 INFO - PID 8081 | Cycle 1(1): loaded http://localhost:43716/tests/dromaeo/cssquery-ext.html (next: http://localhost:43716/tests/dromaeo/cssquery-jquery.html) 06:47:08 INFO - PID 8081 | RSS: Main: 176721920 06:47:08 INFO - PID 8081 | 06:50:09 INFO - PID 8081 | Cycle 1(1): loaded http://localhost:43716/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43716/tests/dromaeo/cssquery-mootools.html) 06:50:10 INFO - PID 8081 | RSS: Main: 174747648 06:50:10 INFO - PID 8081 | 06:53:12 INFO - PID 8081 | Cycle 1(1): loaded http://localhost:43716/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43716/tests/dromaeo/cssquery-prototype.html) 06:53:12 INFO - PID 8081 | RSS: Main: 179048448 06:53:12 INFO - PID 8081 | 06:56:15 INFO - PID 8081 | Cycle 1(1): loaded http://localhost:43716/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43716/tests/dromaeo/cssquery-yui.html) 06:56:15 INFO - PID 8081 | RSS: Main: 177332224 06:56:15 INFO - PID 8081 | 06:59:17 INFO - PID 8081 | Cycle 1(1): loaded http://localhost:43716/tests/dromaeo/cssquery-yui.html (next: http://localhost:43716/tests/dromaeo/cssquery-dojo.html) 06:59:17 INFO - PID 8081 | RSS: Main: 175091712 06:59:17 INFO - PID 8081 | 06:59:17 INFO - PID 8081 | __start_tp_report 06:59:17 INFO - PID 8081 | _x_x_mozilla_page_load 06:59:17 INFO - PID 8081 | _x_x_mozilla_page_load_details 06:59:17 INFO - PID 8081 | |i|pagename|runs| 06:59:17 INFO - PID 8081 | |0;dojo.html;2715.0768738628863;2717.0761940940083;2724.673039235292;2743.903963361282;2751.7248275172487;5199.714015729133;5238.5547228485575;5275.28783614212;5284.260203571503;5335.306410166678;5246.344206974129;5260.289860868782;5300.257963885059;5330.466953304667;5375.301210842595;4601.700889442192;4649.139909116807;4661.65037622178;4689.94476242846;4718.221493453593;4691.741954192518;4693.9765301173275;4734.360861283717;4741.596964258025;4756.619470442373;4604.999999999966;4628.39830821991;4660.16117098922;4679.508651591602;4734.337192793012;4702.271147972036;4719.905601887977;4724.149653062447;4739.478657347689;4740.739259340735;4651.139539185261;4659.464161621389;4680.3915490985955;4687.789049492781;4715.31627913954;5105.540501354859;5185.274061631375;5249.527542521153;5262.210668399733;5277.604179686539;5702.686352250625;5709.429057094258;5712.714364281811;5713.314402271712;5760.683162426065;5718.656880587178;5728.198052272685;5738.254026976508;5741.712914354265;5745.1669507921115;5242.13504771716;5301.973490132525;5334.386545547234;5344.118220493575;5376.731163441812;5884.382139875337;5902.114682797529;5902.557308201816;5918.763249470059;5956.821295361146;5499.670019798825;5579.442055794388;5587.1339942309005;5685.545156387479;5691.487766100988;5565.9443405566235;5596.300462442195;5627.606067575312;5739.339975902824;5751.884962300815;5587.217789509472;5627.746751396197;5645.435456454322;5673.404292549306;5674.432556744375;5562.249096372019;5574.888502230014;5634.436556344414;5648.068068768689;5654.095344744821;4730.9763451182525;4737.218358970731;4744.312074749142;4750;4791.281307803788;4030.1133750574827;4046.1503084352616;4062.715609907278;4068.145689405258;4091.243120022805;4696.1546921554445;4804.807807687724;4806.423229212517;4854.660173787801;4869.123557759637;5702.6863522506665;5703.486686198262;5716.485516303553;5719.513841323451;5760.596758226884;4803.711777293373;4817.975910120497;4819.349387832598;4820.807167713322;4847.563719265283;4916.459189489225;4994.80020799164;4999.450060493343;5045.091883461012;5050.292958985745;5306.575473961997;5310;5310.6457853247175;5319.760610772447;5362.705051222064;5699.5155411790465;5715.942840571541;5716.628419152742;5725.799597014085;5727.1695604138;5169.327987361769;5235.110031294766;5257.158854583248;5294.682319060868;5332.493413125747;5618.438156184512;5663.631863928831;5665.03694371966;5690.971545142248;5703.4296570344295;5605.775768969195;5731.3122425307565;5768.3078030634915;5778.56660750437;5783.566232532493;5456.563474921917;5456.645318054314;5460.781568737365;5499.257600223918;5566.248556444828;5446.264754258283;5463.617546771688;5537.861553461034;5578.246936663499;5585.469380408855;5337.306150200449;5379.65032272901;5401.162819762943;5413.296271484682;5469.699166545878;5582.609217354746;5594;5595.524380427709;5601.579881508822;5647.378788333198;5419.214213939035;5422.593305502024;5443.673379597237;5444.292242008513;5448.83653490396 06:59:17 INFO - PID 8081 | |1;ext.html;683.7538486144987;708.8263375473008;728.6720975560995;1161.930284182949;1213.4054313386443;33677.83161084194;34789.13027174322;34879.4768078479;34942.825285873536;34960.80470343559;32512.18719532013;32909;32917.17707057325;32959.83520082396;33020.17449563762;6171.228596425458;6304.148939893124;6487.481001519867;6634.469242460592;6655.733770649168;6553.705083271264;6575.0466182403525;6648.368405001517;6670.0661907333015;6686.1308029956035;6586.27550969393;6658.134442522465;6687.699053542602;6689.7658581949645;6690.130283063219;6601.93398066018;6622.03980422836;6645.102911107011;6648.434883034948;6653.600783952978;6485.286618471964;6562.93437065628;6565.737370505174;6596.60420374779;6600.966995165041;31070;31259.218519537193;31393;31436.21409464759;31468.527972080206;3038.924026899323;3097.303106800974;3097.845107744604;3116.548100525411;3117.392108538836;24075.7592424077;24163.275101746975;24165.516689666107;24221.152259671002;24268.757312426827;2435.5737745894576;2451.6445115458337;2462.2982450001664;2465.1618449727;2469.4814089041324;143500.28249858684;143944.28027859793;144516;144584.27707861393;148827.99999999892;38346.616533834305;38374.424383634265;38477;38507.42238866419;38555.80722096372;39904.800475997436;39970.20059598792;40027.79986100109;40054.39918401226;40567;13492.730145397038;13538.796918046237;13556.322183890767;13637.590872273848;13663.863361366459;10825.891741082489;10832.620858269922;10847.294925829796;10903.400312982862;10910.072643825364;12962.351882405843;13027.85847039992;13067.411966461532;13087.345632718327;13230.470781168839;5476.288082549243;5481.588880833874;5520.834374968757;5528.281323427928;5536.169574563848;853.1340689200466;894.280104515871;911.4030310146865;911.5624500239921;936.091990768953;20659.58680826375;20966.895165524074;27039;27507.31231719223;28221.43557128846;986.234639994402;989.618996686281;990.9653162139291;996.6212839121232;1000.3697670467559;10862.728431789268;11292.604758833402;11403.885961140448;11523.53905843757;11550.364729939934;171203;171625;172782;173130.13434932745;173757;40601;40672.59327406747;40714.79642601768;40881.59118408778;40928.18143637111;1227.1164761371797;1261.4638778519093;1275.190254188597;1291.205908366348;1299.707565797688;19860.900695497006;19962.10170542358;20367.18531258733;21155.576888461837;21319.25382611601;30228.84885575646;36580;36981;37131.44302835406;37347;158212;159988;160030;160310;160527;30084.097477075724;30110.397792044474;30130.397392051596;30344;30504.542431863985;35512.644873551966;35631.10922226965;36042.8197859009;36209.45685814662;36387.272254554235;27212.72787272181;27414.314642134108;27638.5854212191;27935.860320698266;28456.715432846235;26530.867345663148;26852.59721104146;27634.861825690743;27867.303317417227;28086.719132809227;29353.266168345963;29931.102066938027;30053.69946300509;30450.086497405115;30608.84695576508;26107;26688.19935401941;26919;27030.189094326415;27617.723822761516;21103.36689899244;22269.665955011013;22283.220087296868;22550.4362390935;22744.658830117893 06:59:17 INFO - PID 8081 | |2;jquery.html;388.479437553678;402.83685107531426;420.74124413485697;422.6829877591806;427.5468003915849;17165.656686866256;17565.912170439162;17954.281828726853;17999.100044997762;18572.257109715596;19423;19490.90254548729;19712.70430943537;19725.605487890232;19826.801731982676;5266.447023062581;5356.678599284046;5548.944510554883;5575.219469274305;5595.944040559583;5199.064168449678;5306.7346632668405;5325.334333208349;5329.280547126146;5338.572914166877;5261.158214685651;5262.842114736545;5266.499682530153;5277.736113194344;5298.523132918037;5141.228815677641;5229.633925625189;5258.316418865523;5310.761015754261;5325.254464374991;4757.500462451428;4783.95216047842;4796.472388037313;4801.519848015206;4804.015176888729;21554.784452155436;21961;21972.560548789093;22036.33890983273;22082;1643.909584972826;1653.5783375239357;1678.89087209331;1688.3753011385866;1691.8054423741305;14276.214808185545;14367.568972930829;14476.131432114107;14592.489262875748;14741.926290368587;1956.8434525237947;1967.7638683357945;1992.2927360786857;2033.8271246944028;2034.98982505088;81795.18204817935;82304;82382.58808705978;82718.58640706757;83879.16120838835;11040.779184416268;11102.111831053497;11212.327260364404;11260.211785175123;11514.366709830872;15663.68672626541;15701.293441795147;15789.368425262861;15938.60153496172;15986.200689965455;7823.804404889809;7898.723544675909;8037.517748935083;8119.715809946623;8139.633716482773;7341.669624866894;7376.225496322916;7382.741604043833;7594.772156835304;7636.503627264321;6877.552959057745;6945.340192681687;6950.6177160256675;7098.112735908012;7136.464765142635;2000.1999200319988;2015.6069566434699;2032;2035;2067.0388269454775;871.1332224436726;903.823754367905;906.5784410249134;912.1516989200107;940.7601061729353;16805.24376403065;16951;17434.302627894744;17792.843465174723;18027.098645067694;870.508162887979;871.2724874729672;887.8756974023642;900.4417261298037;907.695921866169;9216.677416290398;9380.29647776406;9427.245820334358;9608.231341492663;9720.611175552898;334822;338297;339232;342773;343591;61422.69288653528;67615.66192169007;78212;78291.60854195806;79104;1046.2676126711333;1050.7110544600296;1099.0383414512303;1103.3214573037524;1105.8783533811275;17196.312147514458;17409.47771566855;17861.73207401864;18140.092995350442;18178.72731909049;38469.42295865508;38831;39224;39341.75468764895;40853;47806.282905757136;48016.75991620019;48955;49026;50430;8171.223733745284;8191.918080819116;8289.295409890226;8437.746867593982;8452.36607254446;11997.404360080533;12208.389580521116;12243;12305.138640295094;12458.065645076837;10430.947845260725;10447.582096716047;10559.15526757873;10792.730181745204;10958.506867190836;9632.566534506104;9727.65953191635;9829.803403932025;9907.256955728206;10111.292209545556;10386.42874641902;10556.366618002945;10586.153107751516;10773.51519181623;11081.667549973514;8012.639431225492;8147.840822182008;8158.877616835871;8470.068292487698;8528.104549022264;10614.575416983234;10654.89345106539;10713.625023124154;10768.192385570957;11124.332540047622 06:59:17 INFO - PID 8081 | |3;mootools.html;1251.4681260464301;1298.227554605011;1301.4468850738433;1311.96720081998;1331.2079312808878;10376.688699339022;10665.626703065394;10898.564057437703;10941.179411544135;11042.889571104286;10324.432156231424;10394.37633741976;10402.687919362412;10440.895591044087;10512.78974420511;2183.366823621148;2200.6478963365867;2217.7449593296737;2218.9334319970426;2226.2764601504496;2117.788221177885;2146.409737322241;2160.5570857974158;2167.089822274648;2168.913243470259;1922.1254329280143;1974.3682021753045;1986.6424043672134;1989.6915978023358;1994.172418446343;2051.415346626204;2058.670612701968;2084.718562993992;2087.9582408351826;2093.497560585464;2002.1891134090572;2014.043329418529;2030.6446371885008;2139.0374331550865;2154.396768904709;10588.78822423555;10591.205659575486;10667.466626668713;10682.412467314294;10698.465076746132;5359.705216213107;5565.0817615093465;5598.804041858556;5611.494965453129;5614.466625670555;2954.9113526594238;3091.3199096199023;3114.6106736657916;3125;3144.6698096699974;976.829054915387;981.842905135182;989.3618615992716;990.4651488196365;996.5465713100522;14721.411143554245;14864.554063378117;14938.70122597542;14944.476943307041;14948.953573249768;4523.231050721385;4662.393888794503;4740.739259340769;4764.952350476451;4792.832250871203;10629.73425664349;10646.467676616137;10652.414117223472;10666.466676666136;10677.092447141924;5378.865528361822;5532.474414930575;5556.083246264321;5556.583256255797;5582.33012038558;5045.7981680732355;5125.923111153335;5144.43411224765;5147.073526765218;5171.146760784503;3610.4764809102535;3664.04734768962;3710.552884375096;3769.830357633913;3804.9619503804606;1046.586598293685;1059.1262208677872;1069.1767339148812;1070.8714954205388;1076.2036093291065;646.9741210351533;717.8887272472775;726.3680597879772;729.5877829026583;747.234085062815;5767.36558978512;5856.619319744203;5877.647341159544;5912.674802885883;6002.369751176151;551.503646717957;565.8104534980828;572.6106247751569;574.5461085742301;575.0712599152339;3544.078539579728;3749.8125093745202;4239.215745087169;4249.68127390447;4654.232051711429;13331.93334033343;13571.86428135706;13779.311034448237;13836.86163138376;13866.029377943649;13184.670383240304;13616;13734.175949442866;13831.79252311216;13837.584872453843;7510.737124200517;7624.847503049908;7780.8832867507035;7824.569648669264;7825.726099586487;6372.36276372359;6516.152900123143;6543.738250470118;6666;6810.863782724218;11990.640280791591;12008.279503229835;12150.21023633461;12235.204711693712;12326.75346493083;12471.625851224479;12570.874291257336;12658.556950506689;12703.42834572428;12778.936105319413;7615.352695020985;7765.417593680384;7776.84446311082;7782.766517004273;7818.296353328228;9454.338196326466;9630.566624502055;9636.325457217927;9644;9651.758706032406;7893.092294386219;8052.597370131352;8126.55303958288;8302.958485207535;8550.871736924075;8324.500529968222;8414.663413463393;8432.45189062709;8499.702510412106;8537.74386768398;7633.084029916446;7744.225577442211;7765.961170194339;7787.338076263354;7788.766337009899;4974.253861920741;5368.40947495783;5415.702136382537;5441.918371224514;5645.858853528694;5075.644704870771;5207.817726379559;5318.361796584435;5349.812756553502;5629.915551266652 06:59:17 INFO - PID 8081 | |4;prototype.html;337.8429030500818;364.456959130895;367.98712045078395;369.24120931485794;370.43323714716496;5336.626436149461;5542.5565954723625;5573.386927437979;5593.216949627051;5608.130739735338;5330.38700549436;5377.354717433914;5382.730863456831;5411.756470958807;5417.539509141728;4027.7986100695066;4034.2939985502567;4034.495688038995;4038.757674539522;4040.5757395473493;3928.292907276689;4007.338789099795;4021.557628660845;4049.372347286175;4067.877963661095;4028.858989935353;4029.798510074499;4041.1715598302276;4044.777537235451;4045.656119229869;3987.8404863805413;4020.778857162855;4025.376066709665;4036.2734707752593;4036.354183330682;3507.7895326280504;3510.6489351064943;3516.261585067139;3518;3525.294941011808;5253.3958594761325;5305.7612407441375;5310.787568497255;5315.883664430474;5320.228566857784;4730.787114579818;4746.169420351424;4748.9525104748855;4757.881052973668;4761.761911904391;5583.553315734732;5717.599768016241;5729.770809167629;5737.799177028784;5743.483086522233;3938.35017222158;3956.6834653227675;3958.5249770027494;3959.4852669153115;3967.1668949520636;5874.32445268791;6041.3354531002;6075.5320211809285;6094.390560943914;6117.480014198754;3987.840486380512;4014.237294913957;4018.3972404139613;4029.516458024997;4032.334664780337;4047.5547689754103;4049.331860243086;4067.576348278138;4073.89815254621;4081.91836163281;4624.9768751156025;4693.817374920678;4715.504871988461;4717.589054234302;4731.455882573479;5764.279465066867;5812.82561523155;5813.854653633608;5818.44724751148;5831.241938547962;1397.2873834344557;1408.978865317021;1412.3220853990142;1412.8344116104256;1420.2472689474596;901.8692289617969;914.4193437167313;949.8812648418948;958.8274110660009;959.6449313753956;4961.3952674846;5019.698818070928;5026.547610715053;5052;5056.570191533688;5952.7321270542925;5974.3428222895445;5985.610935289193;5986.132010858401;5993.850153746104;4851.975740121347;4943.2585112233455;4982.576480999083;5002.874928126753;5005.199168133081;3136.760979413119;3149.889753858604;3169.730572901329;3170.3342298117655;3174.904752857418;5467.534655133065;5511.173324001352;5529.806456773994;5532.253145825262;5542.362628297717;5973.790917317873;6005.189299444519;6045;6082.452579267887;6099.573029887865;5493.505584497414;5518.199166724975;5524.8342549723575;5532.30846144232;5583.609147359808;5794.855128621818;5843.152742852348;5882.764689412375;5926.140709597171;5938.970305148447;5850.23946886919;5878.676672783038;5896.557758168069;5905.793297234576;5914.292707537247;5343.732813359395;5548.195511650869;5550.833474995757;5552.7778888843995;5583.944160558342;4003.599640035973;4022.4770779798437;4025.496812898388;4032.9395059074723;4041.4948131483566;5881.676507792113;6013.699315034319;6017;6032.638041717511;6041.154238406539;5770.855728606818;5771.797987070432;5797.159411885169;5800.187973683604;5827.679477628772;5750.482456578928;5789.45000224978;5794.2177805997335;5817.621854579439;5858.9121163181735;5618.634788738719;5676.801311954062;5693.9430605693415;5741.110127930177;5746.683932383759;5784.855378615568;5801.767929282782;5813.215215945793;5882.470577648032;5899.790542938773;5411.242426060433;5632.774689012557;5663.518600918968;5684.488396044376;5695.2311437957005 06:59:17 INFO - PID 8081 | |5;yui.html;745.4930647159929;751.857147142043;759.4152502573019;770.4029377232644;773.6595897804965;11012.944935275313;11646.592369267077;13458.865411345883;14558.417663293456;14563.053401528907;15216.467423640175;15973.920130399332;16007.119608421532;16025.198740063008;16069.517914462556;896.291929375794;908.1327332397544;915.2632131134434;916.3860213656833;917.9265658747285;918.9678361257357;920.2683866326253;922.4880191493718;923.7275003873873;927.5408672707019;955.8136163448096;959.4387283439162;960.4141473701037;964.9614015439374;968.8498282766183;942.1803031362724;946.7538440005613;953.275510611933;953.594722243044;957.3729207369149;689.8447849233883;698.3470455124475;700.4361489001352;702.3468174597622;703.0298188499888;12881.420336084899;12909.225446473241;12914.612561623166;12985.09104362695;13040.673983150402;16031.759523607156;16313.836861631351;16415.753763693556;16542.503724888153;16588.58528536796;12405.93797031018;12826.038047146501;12910.87089129106;12954.352282385844;13080.149790263698;3035.48396772547;3067.5091985282247;3083.5528848316867;3093.752499800011;3096.6748491408302;78072.21927780763;78076;78344.60827695882;80080;81387;12213.206141600767;12497.56258530947;12504.062195335386;12527.18573292733;12584.937075314565;21983.670244946337;22317;22466;22717.545649087257;22724.4318892029;5693.089105743061;5710.2862142232225;5716.42835716425;5752.13717942312;5762.481376676119;2748.3816141368034;2814.746672799417;2819.6193513875774;2832.3344014156655;2833.8158019728653;3380.036689543468;3388.3223355329033;3396.592408910897;3444;3447.7069449096607;632.705791806812;645.6319897658384;698.9860202795916;741.1735914455344;742.5841528743921;577.7573419163878;581.2588949089944;588.7556663984484;596.8030549918517;617.8477140133618;9357.20463760588;9492.623569582373;9668.951655241679;9864.901350986542;10005.44970026641;564.7007086244297;574.4083593898291;588.4674369695432;595.458133098878;606.3178923710825;3974.18529201513;4063.756174629532;4099.282625540519;4139.254934111888;4183.6234738873645;84340.57829710812;85982.57008715041;86462.56768716242;87384.12615873887;88853;76540.61729691316;76852.77309747906;78301.60849195717;78832.60583697159;79089.60455197687;66102.66948665226;67587.66206169037;68002.3199767996;68005.31994680088;69107;10210.744731381477;10971.451427428756;11041.33751974884;11121.443927803739;11150.442477875911;29439.26401839971;29481.852590736908;29761.851190743906;29885.252868678457;30701.23246918845;37477.43783843299;38070.2385952285;38184.64476203348;38869.22261554696;39147.41278880876;14528.128312301296;14589.85410145885;14791.260436977893;14979.251037447866;14982.40070397172;15256.389744410099;15337.309821058303;15520.5343839685;15522.5343239703;15618.687626247638;15484.458043968407;15785.921070394574;15816.288267028242;15817.841821582097;16240;15351.385944562538;15453;15709.21453927322;15748.133852638215;15929.761053584438;13914.930425347808;14307.57077287683;14399.656818487772;14465.855341446451;14605.488807891672;10532.526036328536;10818.891811081789;11129.499172537093;11195.72010699739;11648.126390520576;11286.943565282121;11937.940310298392;12021.519139234333;12038.458269378074;12085.637430877088 06:59:17 INFO - PID 8081 | __end_tp_report 06:59:17 INFO - PID 8081 | __start_cc_report 06:59:17 INFO - PID 8081 | _x_x_mozilla_cycle_collect,351 06:59:17 INFO - PID 8081 | __end_cc_report 06:59:17 INFO - PID 8081 | __startTimestamp1495720757839__endTimestamp 06:59:17 INFO - PID 8081 | 06:59:17 INFO - PID 8081 | ------- Summary: start ------- 06:59:17 INFO - PID 8081 | Number of tests: 6 06:59:17 INFO - PID 8081 | 06:59:17 INFO - PID 8081 | [#0] dojo.html Cycles:165 Average:5196.56 Median:5344.12 stddev:620.65 (11.6%) stddev-sans-first:591.24 06:59:17 INFO - PID 8081 | Values: 2715.1 2717.1 2724.7 2743.9 2751.7 5199.7 5238.6 5275.3 5284.3 5335.3 5246.3 5260.3 5300.3 5330.5 5375.3 4601.7 4649.1 4661.7 4689.9 4718.2 4691.7 4694.0 4734.4 4741.6 4756.6 4605.0 4628.4 4660.2 4679.5 4734.3 4702.3 4719.9 4724.1 4739.5 4740.7 4651.1 4659.5 4680.4 4687.8 4715.3 5105.5 5185.3 5249.5 5262.2 5277.6 5702.7 5709.4 5712.7 5713.3 5760.7 5718.7 5728.2 5738.3 5741.7 5745.2 5242.1 5302.0 5334.4 5344.1 5376.7 5884.4 5902.1 5902.6 5918.8 5956.8 5499.7 5579.4 5587.1 5685.5 5691.5 5565.9 5596.3 5627.6 5739.3 5751.9 5587.2 5627.7 5645.4 5673.4 5674.4 5562.2 5574.9 5634.4 5648.1 5654.1 4731.0 4737.2 4744.3 4750.0 4791.3 4030.1 4046.2 4062.7 4068.1 4091.2 4696.2 4804.8 4806.4 4854.7 4869.1 5702.7 5703.5 5716.5 5719.5 5760.6 4803.7 4818.0 4819.3 4820.8 4847.6 4916.5 4994.8 4999.5 5045.1 5050.3 5306.6 5310.0 5310.6 5319.8 5362.7 5699.5 5715.9 5716.6 5725.8 5727.2 5169.3 5235.1 5257.2 5294.7 5332.5 5618.4 5663.6 5665.0 5691.0 5703.4 5605.8 5731.3 5768.3 5778.6 5783.6 5456.6 5456.6 5460.8 5499.3 5566.2 5446.3 5463.6 5537.9 5578.2 5585.5 5337.3 5379.7 5401.2 5413.3 5469.7 5582.6 5594.0 5595.5 5601.6 5647.4 5419.2 5422.6 5443.7 5444.3 5448.8 06:59:17 INFO - PID 8081 | 06:59:17 INFO - PID 8081 | [#1] ext.html Cycles:180 Average:30504.17 Median:16691.46 stddev:41106.31 (246.3%) stddev-sans-first:41160.63 06:59:17 INFO - PID 8081 | Values: 683.8 708.8 728.7 1161.9 1213.4 33677.8 34789.1 34879.5 34942.8 34960.8 32512.2 32909.0 32917.2 32959.8 33020.2 6171.2 6304.1 6487.5 6634.5 6655.7 6553.7 6575.0 6648.4 6670.1 6686.1 6586.3 6658.1 6687.7 6689.8 6690.1 6601.9 6622.0 6645.1 6648.4 6653.6 6485.3 6562.9 6565.7 6596.6 6601.0 31070.0 31259.2 31393.0 31436.2 31468.5 3038.9 3097.3 3097.8 3116.5 3117.4 24075.8 24163.3 24165.5 24221.2 24268.8 2435.6 2451.6 2462.3 2465.2 2469.5 143500.3 143944.3 144516.0 144584.3 148828.0 38346.6 38374.4 38477.0 38507.4 38555.8 39904.8 39970.2 40027.8 40054.4 40567.0 13492.7 13538.8 13556.3 13637.6 13663.9 10825.9 10832.6 10847.3 10903.4 10910.1 12962.4 13027.9 13067.4 13087.3 13230.5 5476.3 5481.6 5520.8 5528.3 5536.2 853.1 894.3 911.4 911.6 936.1 20659.6 20966.9 27039.0 27507.3 28221.4 986.2 989.6 991.0 996.6 1000.4 10862.7 11292.6 11403.9 11523.5 11550.4 171203.0 171625.0 172782.0 173130.1 173757.0 40601.0 40672.6 40714.8 40881.6 40928.2 1227.1 1261.5 1275.2 1291.2 1299.7 19860.9 19962.1 20367.2 21155.6 21319.3 30228.8 36580.0 36981.0 37131.4 37347.0 158212.0 159988.0 160030.0 160310.0 160527.0 30084.1 30110.4 30130.4 30344.0 30504.5 35512.6 35631.1 36042.8 36209.5 36387.3 27212.7 27414.3 27638.6 27935.9 28456.7 26530.9 26852.6 27634.9 27867.3 28086.7 29353.3 29931.1 30053.7 30450.1 30608.8 26107.0 26688.2 26919.0 27030.2 27617.7 21103.4 22269.7 22283.2 22550.4 22744.7 06:59:17 INFO - PID 8081 | 06:59:17 INFO - PID 8081 | [#2] jquery.html Cycles:180 Average:23814.93 Median:19872.30 stddev:56596.99 (284.8%) stddev-sans-first:56728.43 06:59:17 INFO - PID 8081 | Values: 388.5 402.8 420.7 422.7 427.5 17165.7 17565.9 17954.3 17999.1 18572.3 19423.0 19490.9 19712.7 19725.6 19826.8 5266.4 5356.7 5548.9 5575.2 5595.9 5199.1 5306.7 5325.3 5329.3 5338.6 5261.2 5262.8 5266.5 5277.7 5298.5 5141.2 5229.6 5258.3 5310.8 5325.3 4757.5 4784.0 4796.5 4801.5 4804.0 21554.8 21961.0 21972.6 22036.3 22082.0 1643.9 1653.6 1678.9 1688.4 1691.8 14276.2 14367.6 14476.1 14592.5 14741.9 1956.8 1967.8 1992.3 2033.8 2035.0 81795.2 82304.0 82382.6 82718.6 83879.2 11040.8 11102.1 11212.3 11260.2 11514.4 15663.7 15701.3 15789.4 15938.6 15986.2 7823.8 7898.7 8037.5 8119.7 8139.6 7341.7 7376.2 7382.7 7594.8 7636.5 6877.6 6945.3 6950.6 7098.1 7136.5 2000.2 2015.6 2032.0 2035.0 2067.0 871.1 903.8 906.6 912.2 940.8 16805.2 16951.0 17434.3 17792.8 18027.1 870.5 871.3 887.9 900.4 907.7 9216.7 9380.3 9427.2 9608.2 9720.6 334822.0 338297.0 339232.0 342773.0 343591.0 61422.7 67615.7 78212.0 78291.6 79104.0 1046.3 1050.7 1099.0 1103.3 1105.9 17196.3 17409.5 17861.7 18140.1 18178.7 38469.4 38831.0 39224.0 39341.8 40853.0 47806.3 48016.8 48955.0 49026.0 50430.0 8171.2 8191.9 8289.3 8437.7 8452.4 11997.4 12208.4 12243.0 12305.1 12458.1 10430.9 10447.6 10559.2 10792.7 10958.5 9632.6 9727.7 9829.8 9907.3 10111.3 10386.4 10556.4 10586.2 10773.5 11081.7 8012.6 8147.8 8158.9 8470.1 8528.1 10614.6 10654.9 10713.6 10768.2 11124.3 06:59:17 INFO - PID 8081 | 06:59:17 INFO - PID 8081 | [#3] mootools.html Cycles:180 Average:6360.03 Median:3787.40 stddev:4158.63 (109.8%) stddev-sans-first:4152.58 06:59:17 INFO - PID 8081 | Values: 1251.5 1298.2 1301.4 1312.0 1331.2 10376.7 10665.6 10898.6 10941.2 11042.9 10324.4 10394.4 10402.7 10440.9 10512.8 2183.4 2200.6 2217.7 2218.9 2226.3 2117.8 2146.4 2160.6 2167.1 2168.9 1922.1 1974.4 1986.6 1989.7 1994.2 2051.4 2058.7 2084.7 2088.0 2093.5 2002.2 2014.0 2030.6 2139.0 2154.4 10588.8 10591.2 10667.5 10682.4 10698.5 5359.7 5565.1 5598.8 5611.5 5614.5 2954.9 3091.3 3114.6 3125.0 3144.7 976.8 981.8 989.4 990.5 996.5 14721.4 14864.6 14938.7 14944.5 14949.0 4523.2 4662.4 4740.7 4765.0 4792.8 10629.7 10646.5 10652.4 10666.5 10677.1 5378.9 5532.5 5556.1 5556.6 5582.3 5045.8 5125.9 5144.4 5147.1 5171.1 3610.5 3664.0 3710.6 3769.8 3805.0 1046.6 1059.1 1069.2 1070.9 1076.2 647.0 717.9 726.4 729.6 747.2 5767.4 5856.6 5877.6 5912.7 6002.4 551.5 565.8 572.6 574.5 575.1 3544.1 3749.8 4239.2 4249.7 4654.2 13331.9 13571.9 13779.3 13836.9 13866.0 13184.7 13616.0 13734.2 13831.8 13837.6 7510.7 7624.8 7780.9 7824.6 7825.7 6372.4 6516.2 6543.7 6666.0 6810.9 11990.6 12008.3 12150.2 12235.2 12326.8 12471.6 12570.9 12658.6 12703.4 12778.9 7615.4 7765.4 7776.8 7782.8 7818.3 9454.3 9630.6 9636.3 9644.0 9651.8 7893.1 8052.6 8126.6 8303.0 8550.9 8324.5 8414.7 8432.5 8499.7 8537.7 7633.1 7744.2 7766.0 7787.3 7788.8 4974.3 5368.4 5415.7 5441.9 5645.9 5075.6 5207.8 5318.4 5349.8 5629.9 06:59:17 INFO - PID 8081 | 06:59:17 INFO - PID 8081 | [#4] prototype.html Cycles:180 Average:4717.80 Median:5411.50 stddev:1423.25 (26.3%) stddev-sans-first:1388.76 06:59:17 INFO - PID 8081 | Values: 337.8 364.5 368.0 369.2 370.4 5336.6 5542.6 5573.4 5593.2 5608.1 5330.4 5377.4 5382.7 5411.8 5417.5 4027.8 4034.3 4034.5 4038.8 4040.6 3928.3 4007.3 4021.6 4049.4 4067.9 4028.9 4029.8 4041.2 4044.8 4045.7 3987.8 4020.8 4025.4 4036.3 4036.4 3507.8 3510.6 3516.3 3518.0 3525.3 5253.4 5305.8 5310.8 5315.9 5320.2 4730.8 4746.2 4749.0 4757.9 4761.8 5583.6 5717.6 5729.8 5737.8 5743.5 3938.4 3956.7 3958.5 3959.5 3967.2 5874.3 6041.3 6075.5 6094.4 6117.5 3987.8 4014.2 4018.4 4029.5 4032.3 4047.6 4049.3 4067.6 4073.9 4081.9 4625.0 4693.8 4715.5 4717.6 4731.5 5764.3 5812.8 5813.9 5818.4 5831.2 1397.3 1409.0 1412.3 1412.8 1420.2 901.9 914.4 949.9 958.8 959.6 4961.4 5019.7 5026.5 5052.0 5056.6 5952.7 5974.3 5985.6 5986.1 5993.9 4852.0 4943.3 4982.6 5002.9 5005.2 3136.8 3149.9 3169.7 3170.3 3174.9 5467.5 5511.2 5529.8 5532.3 5542.4 5973.8 6005.2 6045.0 6082.5 6099.6 5493.5 5518.2 5524.8 5532.3 5583.6 5794.9 5843.2 5882.8 5926.1 5939.0 5850.2 5878.7 5896.6 5905.8 5914.3 5343.7 5548.2 5550.8 5552.8 5583.9 4003.6 4022.5 4025.5 4032.9 4041.5 5881.7 6013.7 6017.0 6032.6 6041.2 5770.9 5771.8 5797.2 5800.2 5827.7 5750.5 5789.5 5794.2 5817.6 5858.9 5618.6 5676.8 5693.9 5741.1 5746.7 5784.9 5801.8 5813.2 5882.5 5899.8 5411.2 5632.8 5663.5 5684.5 5695.2 06:59:17 INFO - PID 8081 | 06:59:17 INFO - PID 8081 | [#5] yui.html Cycles:180 Average:17538.79 Median:3238.36 stddev:23117.56 (713.9%) stddev-sans-first:23148.02 06:59:17 INFO - PID 8081 | Values: 745.5 751.9 759.4 770.4 773.7 11012.9 11646.6 13458.9 14558.4 14563.1 15216.5 15973.9 16007.1 16025.2 16069.5 896.3 908.1 915.3 916.4 917.9 919.0 920.3 922.5 923.7 927.5 955.8 959.4 960.4 965.0 968.8 942.2 946.8 953.3 953.6 957.4 689.8 698.3 700.4 702.3 703.0 12881.4 12909.2 12914.6 12985.1 13040.7 16031.8 16313.8 16415.8 16542.5 16588.6 12405.9 12826.0 12910.9 12954.4 13080.1 3035.5 3067.5 3083.6 3093.8 3096.7 78072.2 78076.0 78344.6 80080.0 81387.0 12213.2 12497.6 12504.1 12527.2 12584.9 21983.7 22317.0 22466.0 22717.5 22724.4 5693.1 5710.3 5716.4 5752.1 5762.5 2748.4 2814.7 2819.6 2832.3 2833.8 3380.0 3388.3 3396.6 3444.0 3447.7 632.7 645.6 699.0 741.2 742.6 577.8 581.3 588.8 596.8 617.8 9357.2 9492.6 9669.0 9864.9 10005.4 564.7 574.4 588.5 595.5 606.3 3974.2 4063.8 4099.3 4139.3 4183.6 84340.6 85982.6 86462.6 87384.1 88853.0 76540.6 76852.8 78301.6 78832.6 79089.6 66102.7 67587.7 68002.3 68005.3 69107.0 10210.7 10971.5 11041.3 11121.4 11150.4 29439.3 29481.9 29761.9 29885.3 30701.2 37477.4 38070.2 38184.6 38869.2 39147.4 14528.1 14589.9 14791.3 14979.3 14982.4 15256.4 15337.3 15520.5 15522.5 15618.7 15484.5 15785.9 15816.3 15817.8 16240.0 15351.4 15453.0 15709.2 15748.1 15929.8 13914.9 14307.6 14399.7 14465.9 14605.5 10532.5 10818.9 11129.5 11195.7 11648.1 11286.9 11937.9 12021.5 12038.5 12085.6 06:59:17 INFO - PID 8081 | -------- Summary: end -------- 06:59:17 INFO - PID 8081 | 06:59:18 INFO - TEST-INFO | 8081: exit 0 06:59:18 INFO - TEST-OK | dromaeo_css | took 1146398ms 06:59:18 INFO - TEST-START | kraken 06:59:18 INFO - operating with platform_type : linux_ 06:59:18 INFO - Initialising browser for kraken test... 06:59:18 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43716/getInfo.html -profile /tmp/tmpEmWU3J/profile 06:59:18 INFO - TEST-INFO | started process 8479 (/builds/slave/test/build/application/firefox/firefox http://localhost:43716/getInfo.html) 06:59:53 INFO - TEST-INFO | 8479: killed by SIGTERM 06:59:53 INFO - Browser initialized. 06:59:53 INFO - Running cycle 1/1 for kraken test... 06:59:53 INFO - TEST-INFO | started process 8678 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEmWU3J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:00:05 INFO - PID 8678 | RSS: Main: 172797952 07:00:05 INFO - PID 8678 | 07:00:08 INFO - PID 8678 | Cycle 1(1): loaded http://localhost:43716/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43716/tests/kraken/driver.html?testName=audio-beat-detection) 07:00:09 INFO - PID 8678 | RSS: Main: 178454528 07:00:09 INFO - PID 8678 | 07:00:12 INFO - PID 8678 | Cycle 1(1): loaded http://localhost:43716/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43716/tests/kraken/driver.html?testName=audio-dft) 07:00:12 INFO - PID 8678 | RSS: Main: 177463296 07:00:12 INFO - PID 8678 | 07:00:15 INFO - PID 8678 | Cycle 1(1): loaded http://localhost:43716/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43716/tests/kraken/driver.html?testName=audio-fft) 07:00:16 INFO - PID 8678 | RSS: Main: 175079424 07:00:16 INFO - PID 8678 | 07:00:18 INFO - PID 8678 | Cycle 1(1): loaded http://localhost:43716/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43716/tests/kraken/driver.html?testName=audio-oscillator) 07:00:19 INFO - PID 8678 | RSS: Main: 175677440 07:00:19 INFO - PID 8678 | 07:00:21 INFO - PID 8678 | Cycle 1(1): loaded http://localhost:43716/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43716/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:00:21 INFO - PID 8678 | RSS: Main: 175718400 07:00:21 INFO - PID 8678 | 07:00:25 INFO - PID 8678 | Cycle 1(1): loaded http://localhost:43716/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43716/tests/kraken/driver.html?testName=imaging-darkroom) 07:00:25 INFO - PID 8678 | RSS: Main: 176517120 07:00:25 INFO - PID 8678 | 07:00:29 INFO - PID 8678 | Cycle 1(1): loaded http://localhost:43716/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43716/tests/kraken/driver.html?testName=imaging-desaturate) 07:00:29 INFO - PID 8678 | RSS: Main: 175996928 07:00:29 INFO - PID 8678 | 07:00:32 INFO - PID 8678 | Cycle 1(1): loaded http://localhost:43716/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43716/tests/kraken/driver.html?testName=json-parse-financial) 07:00:33 INFO - PID 8678 | RSS: Main: 177045504 07:00:33 INFO - PID 8678 | 07:00:34 INFO - PID 8678 | Cycle 1(1): loaded http://localhost:43716/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43716/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:00:35 INFO - PID 8678 | RSS: Main: 177049600 07:00:35 INFO - PID 8678 | 07:00:37 INFO - PID 8678 | Cycle 1(1): loaded http://localhost:43716/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43716/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:00:37 INFO - PID 8678 | RSS: Main: 176934912 07:00:37 INFO - PID 8678 | 07:00:40 INFO - PID 8678 | Cycle 1(1): loaded http://localhost:43716/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43716/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:00:41 INFO - PID 8678 | RSS: Main: 176586752 07:00:41 INFO - PID 8678 | 07:00:43 INFO - PID 8678 | Cycle 1(1): loaded http://localhost:43716/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43716/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:00:44 INFO - PID 8678 | RSS: Main: 176959488 07:00:44 INFO - PID 8678 | 07:00:47 INFO - PID 8678 | Cycle 1(1): loaded http://localhost:43716/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43716/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:00:48 INFO - PID 8678 | RSS: Main: 176807936 07:00:48 INFO - PID 8678 | 07:00:49 INFO - PID 8678 | Cycle 1(1): loaded http://localhost:43716/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43716/tests/kraken/driver.html?testName=ai-astar) 07:00:50 INFO - PID 8678 | RSS: Main: 178454528 07:00:50 INFO - PID 8678 | 07:00:50 INFO - PID 8678 | __start_tp_report 07:00:50 INFO - PID 8678 | _x_x_mozilla_page_load 07:00:50 INFO - PID 8678 | _x_x_mozilla_page_load_details 07:00:50 INFO - PID 8678 | |i|pagename|runs| 07:00:50 INFO - PID 8678 | |0;ai-astar;106;114;114;113;113;112;114;114;114;114 07:00:50 INFO - PID 8678 | |1;audio-beat-detection;150;127;126;168;123;124;122;125;147;130 07:00:50 INFO - PID 8678 | |2;audio-dft;166;166;165;167;170;169;167;164;163;164 07:00:50 INFO - PID 8678 | |3;audio-fft;75;74;75;114;74;78;74;73;97;74 07:00:50 INFO - PID 8678 | |4;audio-oscillator;85;83;104;83;84;83;124;83;83;104 07:00:50 INFO - PID 8678 | |5;imaging-gaussian-blur;114;116;114;114;113;114;113;115;113;114 07:00:50 INFO - PID 8678 | |6;imaging-darkroom;151;151;151;152;150;153;151;151;151;152 07:00:50 INFO - PID 8678 | |7;imaging-desaturate;96;95;95;95;95;94;95;95;94;95 07:00:50 INFO - PID 8678 | |8;json-parse-financial;56;54;54;57;56;54;56;55;55;54 07:00:50 INFO - PID 8678 | |9;json-stringify-tinderbox;58;56;57;56;57;57;56;56;56;57 07:00:50 INFO - PID 8678 | |10;stanford-crypto-aes;87;86;97;87;87;96;96;89;126;94 07:00:50 INFO - PID 8678 | |11;stanford-crypto-ccm;137;136;136;136;135;133;143;134;137;135 07:00:50 INFO - PID 8678 | |12;stanford-crypto-pbkdf2;194;189;205;196;186;197;195;200;199;189 07:00:50 INFO - PID 8678 | |13;stanford-crypto-sha256-iterative;73;75;73;75;76;75;74;72;72;73 07:00:50 INFO - PID 8678 | __end_tp_report 07:00:50 INFO - PID 8678 | __start_cc_report 07:00:50 INFO - PID 8678 | _x_x_mozilla_cycle_collect,912 07:00:50 INFO - PID 8678 | __end_cc_report 07:00:50 INFO - PID 8678 | __startTimestamp1495720850185__endTimestamp 07:00:50 INFO - PID 8678 | 07:00:50 INFO - PID 8678 | ------- Summary: start ------- 07:00:50 INFO - PID 8678 | Number of tests: 14 07:00:50 INFO - PID 8678 | 07:00:50 INFO - PID 8678 | [#0] ai-astar Cycles:10 Average:112.80 Median:114.00 stddev:2.49 (2.2%) stddev-sans-first:0.73 07:00:50 INFO - PID 8678 | Values: 106.0 114.0 114.0 113.0 113.0 112.0 114.0 114.0 114.0 114.0 07:00:50 INFO - PID 8678 | 07:00:50 INFO - PID 8678 | [#1] audio-beat-detection Cycles:10 Average:134.20 Median:128.50 stddev:15.48 (12.0%) stddev-sans-first:15.32 07:00:50 INFO - PID 8678 | Values: 150.0 127.0 126.0 168.0 123.0 124.0 122.0 125.0 147.0 130.0 07:00:50 INFO - PID 8678 | 07:00:50 INFO - PID 8678 | [#2] audio-dft Cycles:10 Average:166.10 Median:166.50 stddev:2.23 (1.3%) stddev-sans-first:2.37 07:00:50 INFO - PID 8678 | Values: 166.0 166.0 165.0 167.0 170.0 169.0 167.0 164.0 163.0 164.0 07:00:50 INFO - PID 8678 | 07:00:50 INFO - PID 8678 | [#3] audio-fft Cycles:10 Average:80.80 Median:74.50 stddev:13.69 (18.4%) stddev-sans-first:14.35 07:00:50 INFO - PID 8678 | Values: 75.0 74.0 75.0 114.0 74.0 78.0 74.0 73.0 97.0 74.0 07:00:50 INFO - PID 8678 | 07:00:50 INFO - PID 8678 | [#4] audio-oscillator Cycles:10 Average:91.60 Median:83.00 stddev:14.25 (17.2%) stddev-sans-first:14.92 07:00:50 INFO - PID 8678 | Values: 85.0 83.0 104.0 83.0 84.0 83.0 124.0 83.0 83.0 104.0 07:00:50 INFO - PID 8678 | 07:00:50 INFO - PID 8678 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.94 (0.8%) stddev-sans-first:1.00 07:00:50 INFO - PID 8678 | Values: 114.0 116.0 114.0 114.0 113.0 114.0 113.0 115.0 113.0 114.0 07:00:50 INFO - PID 8678 | 07:00:50 INFO - PID 8678 | [#6] imaging-darkroom Cycles:10 Average:151.30 Median:151.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 07:00:50 INFO - PID 8678 | Values: 151.0 151.0 151.0 152.0 150.0 153.0 151.0 151.0 151.0 152.0 07:00:50 INFO - PID 8678 | 07:00:50 INFO - PID 8678 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 07:00:50 INFO - PID 8678 | Values: 96.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 07:00:50 INFO - PID 8678 | 07:00:50 INFO - PID 8678 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.50 stddev:1.10 (2.0%) stddev-sans-first:1.12 07:00:50 INFO - PID 8678 | Values: 56.0 54.0 54.0 57.0 56.0 54.0 56.0 55.0 55.0 54.0 07:00:50 INFO - PID 8678 | 07:00:50 INFO - PID 8678 | [#9] json-stringify-tinderbox Cycles:10 Average:56.60 Median:57.00 stddev:0.70 (1.2%) stddev-sans-first:0.53 07:00:50 INFO - PID 8678 | Values: 58.0 56.0 57.0 56.0 57.0 57.0 56.0 56.0 56.0 57.0 07:00:50 INFO - PID 8678 | 07:00:50 INFO - PID 8678 | [#10] stanford-crypto-aes Cycles:10 Average:94.50 Median:91.50 stddev:11.90 (13.0%) stddev-sans-first:12.31 07:00:50 INFO - PID 8678 | Values: 87.0 86.0 97.0 87.0 87.0 96.0 96.0 89.0 126.0 94.0 07:00:50 INFO - PID 8678 | 07:00:50 INFO - PID 8678 | [#11] stanford-crypto-ccm Cycles:10 Average:136.20 Median:136.00 stddev:2.70 (2.0%) stddev-sans-first:2.85 07:00:50 INFO - PID 8678 | Values: 137.0 136.0 136.0 136.0 135.0 133.0 143.0 134.0 137.0 135.0 07:00:50 INFO - PID 8678 | 07:00:50 INFO - PID 8678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.00 Median:196.50 stddev:5.77 (2.9%) stddev-sans-first:6.11 07:00:50 INFO - PID 8678 | Values: 194.0 189.0 205.0 196.0 186.0 197.0 195.0 200.0 199.0 189.0 07:00:50 INFO - PID 8678 | 07:00:50 INFO - PID 8678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.80 Median:74.50 stddev:1.40 (1.9%) stddev-sans-first:1.45 07:00:50 INFO - PID 8678 | Values: 73.0 75.0 73.0 75.0 76.0 75.0 74.0 72.0 72.0 73.0 07:00:50 INFO - PID 8678 | -------- Summary: end -------- 07:00:50 INFO - PID 8678 | 07:00:51 INFO - TEST-INFO | 8678: exit 0 07:00:51 INFO - TEST-OK | kraken | took 92648ms 07:00:51 INFO - SUITE-END | took 1239s 07:00:51 INFO - Completed test suite (00:20:39) 07:00:51 INFO - javascript benchmark 07:00:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6739.089724796573, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2715.0768738628863, 2717.0761940940083, 2724.673039235292, 2743.903963361282, 2751.7248275172487, 5199.714015729133, 5238.5547228485575, 5275.28783614212, 5284.260203571503, 5335.306410166678, 5246.344206974129, 5260.289860868782, 5300.257963885059, 5330.466953304667, 5375.301210842595, 4601.700889442192, 4649.139909116807, 4661.65037622178, 4689.94476242846, 4718.221493453593, 4691.741954192518, 4693.9765301173275, 4734.360861283717, 4741.596964258025, 4756.619470442373, 4604.999999999966, 4628.39830821991, 4660.16117098922, 4679.508651591602, 4734.337192793012, 4702.271147972036, 4719.905601887977, 4724.149653062447, 4739.478657347689, 4740.739259340735, 4651.139539185261, 4659.464161621389, 4680.3915490985955, 4687.789049492781, 4715.31627913954, 5105.540501354859, 5185.274061631375, 5249.527542521153, 5262.210668399733, 5277.604179686539, 5702.686352250625, 5709.429057094258, 5712.714364281811, 5713.314402271712, 5760.683162426065, 5718.656880587178, 5728.198052272685, 5738.254026976508, 5741.712914354265, 5745.1669507921115, 5242.13504771716, 5301.973490132525, 5334.386545547234, 5344.118220493575, 5376.731163441812, 5884.382139875337, 5902.114682797529, 5902.557308201816, 5918.763249470059, 5956.821295361146, 5499.670019798825, 5579.442055794388, 5587.1339942309005, 5685.545156387479, 5691.487766100988, 5565.9443405566235, 5596.300462442195, 5627.606067575312, 5739.339975902824, 5751.884962300815, 5587.217789509472, 5627.746751396197, 5645.435456454322, 5673.404292549306, 5674.432556744375, 5562.249096372019, 5574.888502230014, 5634.436556344414, 5648.068068768689, 5654.095344744821, 4730.9763451182525, 4737.218358970731, 4744.312074749142, 4750.0, 4791.281307803788, 4030.1133750574827, 4046.1503084352616, 4062.715609907278, 4068.145689405258, 4091.243120022805, 4696.1546921554445, 4804.807807687724, 4806.423229212517, 4854.660173787801, 4869.123557759637, 5702.6863522506665, 5703.486686198262, 5716.485516303553, 5719.513841323451, 5760.596758226884, 4803.711777293373, 4817.975910120497, 4819.349387832598, 4820.807167713322, 4847.563719265283, 4916.459189489225, 4994.80020799164, 4999.450060493343, 5045.091883461012, 5050.292958985745, 5306.575473961997, 5310.0, 5310.6457853247175, 5319.760610772447, 5362.705051222064, 5699.5155411790465, 5715.942840571541, 5716.628419152742, 5725.799597014085, 5727.1695604138, 5169.327987361769, 5235.110031294766, 5257.158854583248, 5294.682319060868, 5332.493413125747, 5618.438156184512, 5663.631863928831, 5665.03694371966, 5690.971545142248, 5703.4296570344295, 5605.775768969195, 5731.3122425307565, 5768.3078030634915, 5778.56660750437, 5783.566232532493, 5456.563474921917, 5456.645318054314, 5460.781568737365, 5499.257600223918, 5566.248556444828, 5446.264754258283, 5463.617546771688, 5537.861553461034, 5578.246936663499, 5585.469380408855, 5337.306150200449, 5379.65032272901, 5401.162819762943, 5413.296271484682, 5469.699166545878, 5582.609217354746, 5594.0, 5595.524380427709, 5601.579881508822, 5647.378788333198, 5419.214213939035, 5422.593305502024, 5443.673379597237, 5444.292242008513, 5448.83653490396], "value": 5150.801984082365, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [683.7538486144987, 708.8263375473008, 728.6720975560995, 1161.930284182949, 1213.4054313386443, 33677.83161084194, 34789.13027174322, 34879.4768078479, 34942.825285873536, 34960.80470343559, 32512.18719532013, 32909.0, 32917.17707057325, 32959.83520082396, 33020.17449563762, 6171.228596425458, 6304.148939893124, 6487.481001519867, 6634.469242460592, 6655.733770649168, 6553.705083271264, 6575.0466182403525, 6648.368405001517, 6670.0661907333015, 6686.1308029956035, 6586.27550969393, 6658.134442522465, 6687.699053542602, 6689.7658581949645, 6690.130283063219, 6601.93398066018, 6622.03980422836, 6645.102911107011, 6648.434883034948, 6653.600783952978, 6485.286618471964, 6562.93437065628, 6565.737370505174, 6596.60420374779, 6600.966995165041, 31070.0, 31259.218519537193, 31393.0, 31436.21409464759, 31468.527972080206, 3038.924026899323, 3097.303106800974, 3097.845107744604, 3116.548100525411, 3117.392108538836, 24075.7592424077, 24163.275101746975, 24165.516689666107, 24221.152259671002, 24268.757312426827, 2435.5737745894576, 2451.6445115458337, 2462.2982450001664, 2465.1618449727, 2469.4814089041324, 143500.28249858684, 143944.28027859793, 144516.0, 144584.27707861393, 148827.99999999892, 38346.616533834305, 38374.424383634265, 38477.0, 38507.42238866419, 38555.80722096372, 39904.800475997436, 39970.20059598792, 40027.79986100109, 40054.39918401226, 40567.0, 13492.730145397038, 13538.796918046237, 13556.322183890767, 13637.590872273848, 13663.863361366459, 10825.891741082489, 10832.620858269922, 10847.294925829796, 10903.400312982862, 10910.072643825364, 12962.351882405843, 13027.85847039992, 13067.411966461532, 13087.345632718327, 13230.470781168839, 5476.288082549243, 5481.588880833874, 5520.834374968757, 5528.281323427928, 5536.169574563848, 853.1340689200466, 894.280104515871, 911.4030310146865, 911.5624500239921, 936.091990768953, 20659.58680826375, 20966.895165524074, 27039.0, 27507.31231719223, 28221.43557128846, 986.234639994402, 989.618996686281, 990.9653162139291, 996.6212839121232, 1000.3697670467559, 10862.728431789268, 11292.604758833402, 11403.885961140448, 11523.53905843757, 11550.364729939934, 171203.0, 171625.0, 172782.0, 173130.13434932745, 173757.0, 40601.0, 40672.59327406747, 40714.79642601768, 40881.59118408778, 40928.18143637111, 1227.1164761371797, 1261.4638778519093, 1275.190254188597, 1291.205908366348, 1299.707565797688, 19860.900695497006, 19962.10170542358, 20367.18531258733, 21155.576888461837, 21319.25382611601, 30228.84885575646, 36580.0, 36981.0, 37131.44302835406, 37347.0, 158212.0, 159988.0, 160030.0, 160310.0, 160527.0, 30084.097477075724, 30110.397792044474, 30130.397392051596, 30344.0, 30504.542431863985, 35512.644873551966, 35631.10922226965, 36042.8197859009, 36209.45685814662, 36387.272254554235, 27212.72787272181, 27414.314642134108, 27638.5854212191, 27935.860320698266, 28456.715432846235, 26530.867345663148, 26852.59721104146, 27634.861825690743, 27867.303317417227, 28086.719132809227, 29353.266168345963, 29931.102066938027, 30053.69946300509, 30450.086497405115, 30608.84695576508, 26107.0, 26688.19935401941, 26919.0, 27030.189094326415, 27617.723822761516, 21103.36689899244, 22269.665955011013, 22283.220087296868, 22550.4362390935, 22744.658830117893], "value": 14522.324947690582, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.479437553678, 402.83685107531426, 420.74124413485697, 422.6829877591806, 427.5468003915849, 17165.656686866256, 17565.912170439162, 17954.281828726853, 17999.100044997762, 18572.257109715596, 19423.0, 19490.90254548729, 19712.70430943537, 19725.605487890232, 19826.801731982676, 5266.447023062581, 5356.678599284046, 5548.944510554883, 5575.219469274305, 5595.944040559583, 5199.064168449678, 5306.7346632668405, 5325.334333208349, 5329.280547126146, 5338.572914166877, 5261.158214685651, 5262.842114736545, 5266.499682530153, 5277.736113194344, 5298.523132918037, 5141.228815677641, 5229.633925625189, 5258.316418865523, 5310.761015754261, 5325.254464374991, 4757.500462451428, 4783.95216047842, 4796.472388037313, 4801.519848015206, 4804.015176888729, 21554.784452155436, 21961.0, 21972.560548789093, 22036.33890983273, 22082.0, 1643.909584972826, 1653.5783375239357, 1678.89087209331, 1688.3753011385866, 1691.8054423741305, 14276.214808185545, 14367.568972930829, 14476.131432114107, 14592.489262875748, 14741.926290368587, 1956.8434525237947, 1967.7638683357945, 1992.2927360786857, 2033.8271246944028, 2034.98982505088, 81795.18204817935, 82304.0, 82382.58808705978, 82718.58640706757, 83879.16120838835, 11040.779184416268, 11102.111831053497, 11212.327260364404, 11260.211785175123, 11514.366709830872, 15663.68672626541, 15701.293441795147, 15789.368425262861, 15938.60153496172, 15986.200689965455, 7823.804404889809, 7898.723544675909, 8037.517748935083, 8119.715809946623, 8139.633716482773, 7341.669624866894, 7376.225496322916, 7382.741604043833, 7594.772156835304, 7636.503627264321, 6877.552959057745, 6945.340192681687, 6950.6177160256675, 7098.112735908012, 7136.464765142635, 2000.1999200319988, 2015.6069566434699, 2032.0, 2035.0, 2067.0388269454775, 871.1332224436726, 903.823754367905, 906.5784410249134, 912.1516989200107, 940.7601061729353, 16805.24376403065, 16951.0, 17434.302627894744, 17792.843465174723, 18027.098645067694, 870.508162887979, 871.2724874729672, 887.8756974023642, 900.4417261298037, 907.695921866169, 9216.677416290398, 9380.29647776406, 9427.245820334358, 9608.231341492663, 9720.611175552898, 334822.0, 338297.0, 339232.0, 342773.0, 343591.0, 61422.69288653528, 67615.66192169007, 78212.0, 78291.60854195806, 79104.0, 1046.2676126711333, 1050.7110544600296, 1099.0383414512303, 1103.3214573037524, 1105.8783533811275, 17196.312147514458, 17409.47771566855, 17861.73207401864, 18140.092995350442, 18178.72731909049, 38469.42295865508, 38831.0, 39224.0, 39341.75468764895, 40853.0, 47806.282905757136, 48016.75991620019, 48955.0, 49026.0, 50430.0, 8171.223733745284, 8191.918080819116, 8289.295409890226, 8437.746867593982, 8452.36607254446, 11997.404360080533, 12208.389580521116, 12243.0, 12305.138640295094, 12458.065645076837, 10430.947845260725, 10447.582096716047, 10559.15526757873, 10792.730181745204, 10958.506867190836, 9632.566534506104, 9727.65953191635, 9829.803403932025, 9907.256955728206, 10111.292209545556, 10386.42874641902, 10556.366618002945, 10586.153107751516, 10773.51519181623, 11081.667549973514, 8012.639431225492, 8147.840822182008, 8158.877616835871, 8470.068292487698, 8528.104549022264, 10614.575416983234, 10654.89345106539, 10713.625023124154, 10768.192385570957, 11124.332540047622], "value": 8775.30181474447, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1251.4681260464301, 1298.227554605011, 1301.4468850738433, 1311.96720081998, 1331.2079312808878, 10376.688699339022, 10665.626703065394, 10898.564057437703, 10941.179411544135, 11042.889571104286, 10324.432156231424, 10394.37633741976, 10402.687919362412, 10440.895591044087, 10512.78974420511, 2183.366823621148, 2200.6478963365867, 2217.7449593296737, 2218.9334319970426, 2226.2764601504496, 2117.788221177885, 2146.409737322241, 2160.5570857974158, 2167.089822274648, 2168.913243470259, 1922.1254329280143, 1974.3682021753045, 1986.6424043672134, 1989.6915978023358, 1994.172418446343, 2051.415346626204, 2058.670612701968, 2084.718562993992, 2087.9582408351826, 2093.497560585464, 2002.1891134090572, 2014.043329418529, 2030.6446371885008, 2139.0374331550865, 2154.396768904709, 10588.78822423555, 10591.205659575486, 10667.466626668713, 10682.412467314294, 10698.465076746132, 5359.705216213107, 5565.0817615093465, 5598.804041858556, 5611.494965453129, 5614.466625670555, 2954.9113526594238, 3091.3199096199023, 3114.6106736657916, 3125.0, 3144.6698096699974, 976.829054915387, 981.842905135182, 989.3618615992716, 990.4651488196365, 996.5465713100522, 14721.411143554245, 14864.554063378117, 14938.70122597542, 14944.476943307041, 14948.953573249768, 4523.231050721385, 4662.393888794503, 4740.739259340769, 4764.952350476451, 4792.832250871203, 10629.73425664349, 10646.467676616137, 10652.414117223472, 10666.466676666136, 10677.092447141924, 5378.865528361822, 5532.474414930575, 5556.083246264321, 5556.583256255797, 5582.33012038558, 5045.7981680732355, 5125.923111153335, 5144.43411224765, 5147.073526765218, 5171.146760784503, 3610.4764809102535, 3664.04734768962, 3710.552884375096, 3769.830357633913, 3804.9619503804606, 1046.586598293685, 1059.1262208677872, 1069.1767339148812, 1070.8714954205388, 1076.2036093291065, 646.9741210351533, 717.8887272472775, 726.3680597879772, 729.5877829026583, 747.234085062815, 5767.36558978512, 5856.619319744203, 5877.647341159544, 5912.674802885883, 6002.369751176151, 551.503646717957, 565.8104534980828, 572.6106247751569, 574.5461085742301, 575.0712599152339, 3544.078539579728, 3749.8125093745202, 4239.215745087169, 4249.68127390447, 4654.232051711429, 13331.93334033343, 13571.86428135706, 13779.311034448237, 13836.86163138376, 13866.029377943649, 13184.670383240304, 13616.0, 13734.175949442866, 13831.79252311216, 13837.584872453843, 7510.737124200517, 7624.847503049908, 7780.8832867507035, 7824.569648669264, 7825.726099586487, 6372.36276372359, 6516.152900123143, 6543.738250470118, 6666.0, 6810.863782724218, 11990.640280791591, 12008.279503229835, 12150.21023633461, 12235.204711693712, 12326.75346493083, 12471.625851224479, 12570.874291257336, 12658.556950506689, 12703.42834572428, 12778.936105319413, 7615.352695020985, 7765.417593680384, 7776.84446311082, 7782.766517004273, 7818.296353328228, 9454.338196326466, 9630.566624502055, 9636.325457217927, 9644.0, 9651.758706032406, 7893.092294386219, 8052.597370131352, 8126.55303958288, 8302.958485207535, 8550.871736924075, 8324.500529968222, 8414.663413463393, 8432.45189062709, 8499.702510412106, 8537.74386768398, 7633.084029916446, 7744.225577442211, 7765.961170194339, 7787.338076263354, 7788.766337009899, 4974.253861920741, 5368.40947495783, 5415.702136382537, 5441.918371224514, 5645.858853528694, 5075.644704870771, 5207.817726379559, 5318.361796584435, 5349.812756553502, 5629.915551266652], "value": 4687.448262443546, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.8429030500818, 364.456959130895, 367.98712045078395, 369.24120931485794, 370.43323714716496, 5336.626436149461, 5542.5565954723625, 5573.386927437979, 5593.216949627051, 5608.130739735338, 5330.38700549436, 5377.354717433914, 5382.730863456831, 5411.756470958807, 5417.539509141728, 4027.7986100695066, 4034.2939985502567, 4034.495688038995, 4038.757674539522, 4040.5757395473493, 3928.292907276689, 4007.338789099795, 4021.557628660845, 4049.372347286175, 4067.877963661095, 4028.858989935353, 4029.798510074499, 4041.1715598302276, 4044.777537235451, 4045.656119229869, 3987.8404863805413, 4020.778857162855, 4025.376066709665, 4036.2734707752593, 4036.354183330682, 3507.7895326280504, 3510.6489351064943, 3516.261585067139, 3518.0, 3525.294941011808, 5253.3958594761325, 5305.7612407441375, 5310.787568497255, 5315.883664430474, 5320.228566857784, 4730.787114579818, 4746.169420351424, 4748.9525104748855, 4757.881052973668, 4761.761911904391, 5583.553315734732, 5717.599768016241, 5729.770809167629, 5737.799177028784, 5743.483086522233, 3938.35017222158, 3956.6834653227675, 3958.5249770027494, 3959.4852669153115, 3967.1668949520636, 5874.32445268791, 6041.3354531002, 6075.5320211809285, 6094.390560943914, 6117.480014198754, 3987.840486380512, 4014.237294913957, 4018.3972404139613, 4029.516458024997, 4032.334664780337, 4047.5547689754103, 4049.331860243086, 4067.576348278138, 4073.89815254621, 4081.91836163281, 4624.9768751156025, 4693.817374920678, 4715.504871988461, 4717.589054234302, 4731.455882573479, 5764.279465066867, 5812.82561523155, 5813.854653633608, 5818.44724751148, 5831.241938547962, 1397.2873834344557, 1408.978865317021, 1412.3220853990142, 1412.8344116104256, 1420.2472689474596, 901.8692289617969, 914.4193437167313, 949.8812648418948, 958.8274110660009, 959.6449313753956, 4961.3952674846, 5019.698818070928, 5026.547610715053, 5052.0, 5056.570191533688, 5952.7321270542925, 5974.3428222895445, 5985.610935289193, 5986.132010858401, 5993.850153746104, 4851.975740121347, 4943.2585112233455, 4982.576480999083, 5002.874928126753, 5005.199168133081, 3136.760979413119, 3149.889753858604, 3169.730572901329, 3170.3342298117655, 3174.904752857418, 5467.534655133065, 5511.173324001352, 5529.806456773994, 5532.253145825262, 5542.362628297717, 5973.790917317873, 6005.189299444519, 6045.0, 6082.452579267887, 6099.573029887865, 5493.505584497414, 5518.199166724975, 5524.8342549723575, 5532.30846144232, 5583.609147359808, 5794.855128621818, 5843.152742852348, 5882.764689412375, 5926.140709597171, 5938.970305148447, 5850.23946886919, 5878.676672783038, 5896.557758168069, 5905.793297234576, 5914.292707537247, 5343.732813359395, 5548.195511650869, 5550.833474995757, 5552.7778888843995, 5583.944160558342, 4003.599640035973, 4022.4770779798437, 4025.496812898388, 4032.9395059074723, 4041.4948131483566, 5881.676507792113, 6013.699315034319, 6017.0, 6032.638041717511, 6041.154238406539, 5770.855728606818, 5771.797987070432, 5797.159411885169, 5800.187973683604, 5827.679477628772, 5750.482456578928, 5789.45000224978, 5794.2177805997335, 5817.621854579439, 5858.9121163181735, 5618.634788738719, 5676.801311954062, 5693.9430605693415, 5741.110127930177, 5746.683932383759, 5784.855378615568, 5801.767929282782, 5813.215215945793, 5882.470577648032, 5899.790542938773, 5411.242426060433, 5632.774689012557, 5663.518600918968, 5684.488396044376, 5695.2311437957005], "value": 4272.449890519779, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [745.4930647159929, 751.857147142043, 759.4152502573019, 770.4029377232644, 773.6595897804965, 11012.944935275313, 11646.592369267077, 13458.865411345883, 14558.417663293456, 14563.053401528907, 15216.467423640175, 15973.920130399332, 16007.119608421532, 16025.198740063008, 16069.517914462556, 896.291929375794, 908.1327332397544, 915.2632131134434, 916.3860213656833, 917.9265658747285, 918.9678361257357, 920.2683866326253, 922.4880191493718, 923.7275003873873, 927.5408672707019, 955.8136163448096, 959.4387283439162, 960.4141473701037, 964.9614015439374, 968.8498282766183, 942.1803031362724, 946.7538440005613, 953.275510611933, 953.594722243044, 957.3729207369149, 689.8447849233883, 698.3470455124475, 700.4361489001352, 702.3468174597622, 703.0298188499888, 12881.420336084899, 12909.225446473241, 12914.612561623166, 12985.09104362695, 13040.673983150402, 16031.759523607156, 16313.836861631351, 16415.753763693556, 16542.503724888153, 16588.58528536796, 12405.93797031018, 12826.038047146501, 12910.87089129106, 12954.352282385844, 13080.149790263698, 3035.48396772547, 3067.5091985282247, 3083.5528848316867, 3093.752499800011, 3096.6748491408302, 78072.21927780763, 78076.0, 78344.60827695882, 80080.0, 81387.0, 12213.206141600767, 12497.56258530947, 12504.062195335386, 12527.18573292733, 12584.937075314565, 21983.670244946337, 22317.0, 22466.0, 22717.545649087257, 22724.4318892029, 5693.089105743061, 5710.2862142232225, 5716.42835716425, 5752.13717942312, 5762.481376676119, 2748.3816141368034, 2814.746672799417, 2819.6193513875774, 2832.3344014156655, 2833.8158019728653, 3380.036689543468, 3388.3223355329033, 3396.592408910897, 3444.0, 3447.7069449096607, 632.705791806812, 645.6319897658384, 698.9860202795916, 741.1735914455344, 742.5841528743921, 577.7573419163878, 581.2588949089944, 588.7556663984484, 596.8030549918517, 617.8477140133618, 9357.20463760588, 9492.623569582373, 9668.951655241679, 9864.901350986542, 10005.44970026641, 564.7007086244297, 574.4083593898291, 588.4674369695432, 595.458133098878, 606.3178923710825, 3974.18529201513, 4063.756174629532, 4099.282625540519, 4139.254934111888, 4183.6234738873645, 84340.57829710812, 85982.57008715041, 86462.56768716242, 87384.12615873887, 88853.0, 76540.61729691316, 76852.77309747906, 78301.60849195717, 78832.60583697159, 79089.60455197687, 66102.66948665226, 67587.66206169037, 68002.3199767996, 68005.31994680088, 69107.0, 10210.744731381477, 10971.451427428756, 11041.33751974884, 11121.443927803739, 11150.442477875911, 29439.26401839971, 29481.852590736908, 29761.851190743906, 29885.252868678457, 30701.23246918845, 37477.43783843299, 38070.2385952285, 38184.64476203348, 38869.22261554696, 39147.41278880876, 14528.128312301296, 14589.85410145885, 14791.260436977893, 14979.251037447866, 14982.40070397172, 15256.389744410099, 15337.309821058303, 15520.5343839685, 15522.5343239703, 15618.687626247638, 15484.458043968407, 15785.921070394574, 15816.288267028242, 15817.841821582097, 16240.0, 15351.385944562538, 15453.0, 15709.21453927322, 15748.133852638215, 15929.761053584438, 13914.930425347808, 14307.57077287683, 14399.656818487772, 14465.855341446451, 14605.488807891672, 10532.526036328536, 10818.891811081789, 11129.499172537093, 11195.72010699739, 11648.126390520576, 11286.943565282121, 11937.940310298392, 12021.519139234333, 12038.458269378074, 12085.637430877088], "value": 7125.061355934881, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1556.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 114.0, 113.0, 113.0, 112.0, 114.0, 114.0, 114.0, 114.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 127.0, 126.0, 168.0, 123.0, 124.0, 122.0, 125.0, 147.0, 130.0], "value": 134.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 165.0, 167.0, 170.0, 169.0, 167.0, 164.0, 163.0, 164.0], "value": 166.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 114.0, 74.0, 78.0, 74.0, 73.0, 97.0, 74.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 104.0, 83.0, 84.0, 83.0, 124.0, 83.0, 83.0, 104.0], "value": 91.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 114.0, 114.0, 113.0, 114.0, 113.0, 115.0, 113.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 151.0, 152.0, 150.0, 153.0, 151.0, 151.0, 151.0, 152.0], "value": 151.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 54.0, 57.0, 56.0, 54.0, 56.0, 55.0, 55.0, 54.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 57.0, 56.0, 57.0, 57.0, 56.0, 56.0, 56.0, 57.0], "value": 56.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 97.0, 87.0, 87.0, 96.0, 96.0, 89.0, 126.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 136.0, 136.0, 136.0, 135.0, 133.0, 143.0, 134.0, 137.0, 135.0], "value": 136.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 189.0, 205.0, 196.0, 186.0, 197.0, 195.0, 200.0, 199.0, 189.0], "value": 195.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 73.0, 75.0, 76.0, 75.0, 74.0, 72.0, 72.0, 73.0], "value": 73.8, "unit": "score"}]}]} 07:00:51 INFO - Return code: 0 07:00:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:00:51 INFO - # TBPL SUCCESS # 07:00:51 INFO - Running post-action listener: _resource_record_post_action 07:00:51 INFO - [mozharness: 2017-05-25 14:00:51.500953Z] Finished run-tests step (success) 07:00:51 INFO - Running post-run listener: _resource_record_post_run 07:00:51 INFO - Total resource usage - Wall time: 1255s; CPU: 13.0%; Read bytes: 12288; Write bytes: 399134720; Read time: 332; Write time: 498424 07:00:51 INFO - TinderboxPrint: CPU usage
12.7% 07:00:51 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 332 07:00:51 INFO - TinderboxPrint: I/O write bytes / time
399,134,720 / 498,424 07:00:51 INFO - TinderboxPrint: CPU idle
8,735.9 (87.2%) 07:00:51 INFO - TinderboxPrint: CPU user
1,220.3 (12.2%) 07:00:51 INFO - TinderboxPrint: Swap in / out
0 / 0 07:00:51 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 97628160; Read time: 0; Write time: 199064 07:00:51 INFO - run-tests - Wall time: 1240s; CPU: 13.0%; Read bytes: 12288; Write bytes: 301506560; Read time: 332; Write time: 299360 07:00:52 INFO - Running post-run listener: _upload_blobber_files 07:00:52 INFO - Blob upload gear active. 07:00:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:00:52 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 07:00:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:00:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:00:52 INFO - (blobuploader) - INFO - Open directory for files ... 07:00:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:00:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:00:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:00:53 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:00:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:00:53 INFO - (blobuploader) - INFO - Done attempting. 07:00:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:00:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:00:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:00:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:00:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:00:56 INFO - (blobuploader) - INFO - Done attempting. 07:00:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:00:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:00:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:00:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:00:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:00:57 INFO - (blobuploader) - INFO - Done attempting. 07:00:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:00:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:00:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:00:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:00:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:00:58 INFO - (blobuploader) - INFO - Done attempting. 07:00:58 INFO - (blobuploader) - INFO - Iteration through files over. 07:00:58 INFO - Return code: 0 07:00:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:00:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:00:58 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b227d196bb86ef7fa669c5b4b9c2c2a5b66be3d6c9d3c98f2a68435256ac1fd031b639d262727c6945f11fe1a81ed47088623eb0f7f0444ca1019e0b30d2a6ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f7dbbd8e633bbe5d4bad7f2b381ebe60e94fdb5aca13dae9400d70eac77f9028534c91392e48ee049c09265bd861403ee1f255e4c7b6842df52728e91364d184", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/64e14e19c25b26eb5c4508de8ee7b85610573f8a20499e73b6b1b6fd717342298f8d8ae2440147faf6a0f75044ffa234c92ae094151c7b49961bbb87c8333d73", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0f057ae6203e087e445b3a56385c2fb6d6519915ad4766c7c75c591fdc09ec0e23c4847cab8958ad7e3e0d7158e8bdc1b4fe24bcd18b6927a29edbf86c415381"} 07:00:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:00:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:00:58 INFO - Contents: 07:00:58 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b227d196bb86ef7fa669c5b4b9c2c2a5b66be3d6c9d3c98f2a68435256ac1fd031b639d262727c6945f11fe1a81ed47088623eb0f7f0444ca1019e0b30d2a6ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f7dbbd8e633bbe5d4bad7f2b381ebe60e94fdb5aca13dae9400d70eac77f9028534c91392e48ee049c09265bd861403ee1f255e4c7b6842df52728e91364d184", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/64e14e19c25b26eb5c4508de8ee7b85610573f8a20499e73b6b1b6fd717342298f8d8ae2440147faf6a0f75044ffa234c92ae094151c7b49961bbb87c8333d73", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0f057ae6203e087e445b3a56385c2fb6d6519915ad4766c7c75c591fdc09ec0e23c4847cab8958ad7e3e0d7158e8bdc1b4fe24bcd18b6927a29edbf86c415381"} 07:00:58 INFO - Running post-run listener: copy_logs_to_upload_dir 07:00:58 INFO - Copying logs to upload dir... 07:00:58 INFO - mkdir: /builds/slave/test/build/upload/logs 07:00:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1313.948008 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 54 secs) (at 2017-05-25 07:00:57.978236) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-25 07:00:57.985579) ========= 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=df17445c3590ff7897617a0e00000225-1495708565.450963-2001006645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b227d196bb86ef7fa669c5b4b9c2c2a5b66be3d6c9d3c98f2a68435256ac1fd031b639d262727c6945f11fe1a81ed47088623eb0f7f0444ca1019e0b30d2a6ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f7dbbd8e633bbe5d4bad7f2b381ebe60e94fdb5aca13dae9400d70eac77f9028534c91392e48ee049c09265bd861403ee1f255e4c7b6842df52728e91364d184", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/64e14e19c25b26eb5c4508de8ee7b85610573f8a20499e73b6b1b6fd717342298f8d8ae2440147faf6a0f75044ffa234c92ae094151c7b49961bbb87c8333d73", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0f057ae6203e087e445b3a56385c2fb6d6519915ad4766c7c75c591fdc09ec0e23c4847cab8958ad7e3e0d7158e8bdc1b4fe24bcd18b6927a29edbf86c415381"} build_url:https://queue.taskcluster.net/v1/task/R0ZoKBpfT0uGsv9GuTE9YQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011370 build_url: 'https://queue.taskcluster.net/v1/task/R0ZoKBpfT0uGsv9GuTE9YQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b227d196bb86ef7fa669c5b4b9c2c2a5b66be3d6c9d3c98f2a68435256ac1fd031b639d262727c6945f11fe1a81ed47088623eb0f7f0444ca1019e0b30d2a6ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f7dbbd8e633bbe5d4bad7f2b381ebe60e94fdb5aca13dae9400d70eac77f9028534c91392e48ee049c09265bd861403ee1f255e4c7b6842df52728e91364d184", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/64e14e19c25b26eb5c4508de8ee7b85610573f8a20499e73b6b1b6fd717342298f8d8ae2440147faf6a0f75044ffa234c92ae094151c7b49961bbb87c8333d73", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0f057ae6203e087e445b3a56385c2fb6d6519915ad4766c7c75c591fdc09ec0e23c4847cab8958ad7e3e0d7158e8bdc1b4fe24bcd18b6927a29edbf86c415381"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-25 07:00:58.009923) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 07:00:58.013261) ========= 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=df17445c3590ff7897617a0e00000225-1495708565.450963-2001006645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004437 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 07:00:58.095029) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-25 07:00:58.098381) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-25 07:00:58.098691) ========= ========= Total master_lag: 0.21 =========