builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-012 starttime: 1495873414.22 results: success (0) revision: 1c1bf54915bbf8cda82dbf7985e87b1c0ff30e4c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-27 01:23:34.218645) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-27 01:23:34.219024) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-27 01:23:34.219284) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-27 01:23:34.235110) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 01:23:34.235376) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1495858813.155868-861733865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-27 01:23:35-- 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% 34.1M=0s 2017-05-27 01:23:35 (34.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.221090 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 01:23:34.469046) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 01:23:34.469365) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1495858813.155868-861733865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023313 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 01:23:34.518344) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 01:23:34.518684) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1c1bf54915bbf8cda82dbf7985e87b1c0ff30e4c --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 1c1bf54915bbf8cda82dbf7985e87b1c0ff30e4c --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=2c5dd2b0a310ecf02fd87158000001b4-1495858813.155868-861733865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-27 01:23:35,502 truncating revision to first 12 chars 2017-05-27 01:23:35,502 Setting DEBUG logging. 2017-05-27 01:23:35,502 attempt 1/10 2017-05-27 01:23:35,502 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1c1bf54915bb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-27 01:23:35,920 unpacking tar archive at: mozilla-central-1c1bf54915bb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.772388 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 01:23:35.303225) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-27 01:23:35.303531) ========= script_repo_revision: 1c1bf54915bbf8cda82dbf7985e87b1c0ff30e4c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-27 01:23:35.303908) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-27 01:23:35.304167) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-27 01:23:35.310903) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 49 secs) (at 2017-05-27 01:23:35.311203) ========= /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=2c5dd2b0a310ecf02fd87158000001b4-1495858813.155868-861733865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:23:36 INFO - MultiFileLogger online at 20170527 01:23:36 in /builds/slave/test 01:23:36 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 01:23:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:23:36 INFO - {'append_to_log': False, 01:23:36 INFO - 'base_work_dir': '/builds/slave/test', 01:23:36 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 01:23:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:23:36 INFO - 'branch': 'Firefox-Non-PGO', 01:23:36 INFO - 'buildbot_json_path': 'buildprops.json', 01:23:36 INFO - 'config_files': ('talos/linux_config.py',), 01:23:36 INFO - 'default_actions': ('clobber', 01:23:36 INFO - 'read-buildbot-config', 01:23:36 INFO - 'download-and-extract', 01:23:36 INFO - 'populate-webroot', 01:23:36 INFO - 'create-virtualenv', 01:23:36 INFO - 'install', 01:23:36 INFO - 'run-tests'), 01:23:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:23:36 INFO - 'download_minidump_stackwalk': True, 01:23:36 INFO - 'download_symbols': 'ondemand', 01:23:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:23:36 INFO - 'tooltool.py': '/tools/tooltool.py', 01:23:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:23:36 INFO - '/tools/misc-python/virtualenv.py')}, 01:23:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:23:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:23:36 INFO - 'gecko_profile': False, 01:23:36 INFO - 'gecko_profile_interval': 0, 01:23:36 INFO - 'installer_path': 'installer.exe', 01:23:36 INFO - 'log_level': 'info', 01:23:36 INFO - 'log_name': 'talos', 01:23:36 INFO - 'log_to_console': True, 01:23:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:23:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:23:36 INFO - 'opt_config_files': (), 01:23:36 INFO - 'pip_index': False, 01:23:36 INFO - 'suite': 'dromaeojs-e10s', 01:23:36 INFO - 'system_bits': '32', 01:23:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:23:36 INFO - 'title': 'talos-linux64-ix-012', 01:23:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:23:36 INFO - 'use_talos_json': True, 01:23:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:23:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:23:36 INFO - 'work_dir': 'build'} 01:23:36 INFO - [mozharness: 2017-05-27 08:23:36.401045Z] Running clobber step. 01:23:36 INFO - Running pre-action listener: _resource_record_pre_action 01:23:36 INFO - Running main action method: clobber 01:23:36 INFO - rmtree: /builds/slave/test/build 01:23:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:23:37 INFO - Running post-action listener: _resource_record_post_action 01:23:37 INFO - [mozharness: 2017-05-27 08:23:37.937050Z] Finished clobber step (success) 01:23:37 INFO - [mozharness: 2017-05-27 08:23:37.937148Z] Running read-buildbot-config step. 01:23:37 INFO - Running pre-action listener: _resource_record_pre_action 01:23:37 INFO - Running main action method: read_buildbot_config 01:23:37 INFO - Using buildbot properties: 01:23:37 INFO - { 01:23:37 INFO - "project": "", 01:23:37 INFO - "product": "firefox", 01:23:37 INFO - "who": "archaeopteryx@coole-files.de", 01:23:37 INFO - "installer_path": "public/build/target.tar.bz2", 01:23:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 01:23:37 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 01:23:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 01:23:37 INFO - "stage_platform": "linux64", 01:23:37 INFO - "basedir": "/builds/slave/test", 01:23:37 INFO - "buildnumber": 907, 01:23:37 INFO - "platform": "ubuntu64_hw", 01:23:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:23:37 INFO - "slavebuilddir": "test", 01:23:37 INFO - "taskId": "f3m2dIOlQtGlpkCBL75j1Q", 01:23:37 INFO - "branch": "mozilla-central", 01:23:37 INFO - "script_repo_revision": "production", 01:23:37 INFO - "revision": "1c1bf54915bbf8cda82dbf7985e87b1c0ff30e4c", 01:23:37 INFO - "slavename": "talos-linux64-ix-012", 01:23:37 INFO - "repo_path": "mozilla-central" 01:23:37 INFO - } 01:23:37 INFO - Finding installer, test and symbols from parent task. 01:23:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f3m2dIOlQtGlpkCBL75j1Q'}, attempt #1 01:23:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f3m2dIOlQtGlpkCBL75j1Q'}, attempt #1 01:23:38 INFO - Task dependencies: EE25Ah43Tq2wB9-VWI1O1A 01:23:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EE25Ah43Tq2wB9-VWI1O1A'}, attempt #1 01:23:39 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/EE25Ah43Tq2wB9-VWI1O1A/artifacts/public/build/target.tar.bz2 01:23:39 INFO - Set test_url: https://queue.taskcluster.net/v1/task/EE25Ah43Tq2wB9-VWI1O1A/artifacts/public/build/test_packages.json 01:23:39 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/EE25Ah43Tq2wB9-VWI1O1A/artifacts/public/build/target.crashreporter-symbols.zip 01:23:39 INFO - Running post-action listener: _resource_record_post_action 01:23:39 INFO - [mozharness: 2017-05-27 08:23:39.270806Z] Finished read-buildbot-config step (success) 01:23:39 INFO - [mozharness: 2017-05-27 08:23:39.271027Z] Running download-and-extract step. 01:23:39 INFO - Running pre-action listener: _resource_record_pre_action 01:23:39 INFO - Running main action method: download_and_extract 01:23:39 INFO - mkdir: /builds/slave/test/build/tests 01:23: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')]} 01:23:39 INFO - trying https://queue.taskcluster.net/v1/task/EE25Ah43Tq2wB9-VWI1O1A/artifacts/public/build/target.test_packages.json 01:23:39 INFO - Downloading https://queue.taskcluster.net/v1/task/EE25Ah43Tq2wB9-VWI1O1A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 01:23:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EE25Ah43Tq2wB9-VWI1O1A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 01:23:39 INFO - Downloaded 986 bytes. 01:23:39 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 01:23:39 INFO - Using the following test package requirements: 01:23:39 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 01:23:39 INFO - u'common': [u'target.common.tests.zip'], 01:23:39 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 01:23:39 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 01:23:39 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 01:23:39 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 01:23:39 INFO - u'mozbase': [u'target.common.tests.zip'], 01:23:39 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 01:23:39 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 01:23:39 INFO - u'web-platform': [u'target.common.tests.zip', 01:23:39 INFO - u'target.web-platform.tests.zip'], 01:23:39 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 01:23:39 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 01:23:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EE25Ah43Tq2wB9-VWI1O1A/artifacts/public/build/target.common.tests.zip 01:23:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EE25Ah43Tq2wB9-VWI1O1A/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:23:39 INFO - Fetch https://queue.taskcluster.net/v1/task/EE25Ah43Tq2wB9-VWI1O1A/artifacts/public/build/target.common.tests.zip into memory 01:23:40 INFO - Content-Length response header: 63526727 01:23:40 INFO - Bytes received: 63526727 01:23:51 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 01:23:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EE25Ah43Tq2wB9-VWI1O1A/artifacts/public/build/target.common.tests.zip 01:23:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EE25Ah43Tq2wB9-VWI1O1A/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:23:51 INFO - Fetch https://queue.taskcluster.net/v1/task/EE25Ah43Tq2wB9-VWI1O1A/artifacts/public/build/target.common.tests.zip into memory 01:23:52 INFO - Content-Length response header: 63526727 01:23:52 INFO - Bytes received: 63526727 01:24:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EE25Ah43Tq2wB9-VWI1O1A/artifacts/public/build/target.talos.tests.zip 01:24:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EE25Ah43Tq2wB9-VWI1O1A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 01:24:04 INFO - Fetch https://queue.taskcluster.net/v1/task/EE25Ah43Tq2wB9-VWI1O1A/artifacts/public/build/target.talos.tests.zip into memory 01:24:05 INFO - Content-Length response header: 14441221 01:24:05 INFO - Bytes received: 14441221 01:24:05 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')]} 01:24:05 INFO - trying https://queue.taskcluster.net/v1/task/EE25Ah43Tq2wB9-VWI1O1A/artifacts/public/build/target.tar.bz2 01:24:05 INFO - Downloading https://queue.taskcluster.net/v1/task/EE25Ah43Tq2wB9-VWI1O1A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 01:24:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EE25Ah43Tq2wB9-VWI1O1A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 01:24:06 INFO - Downloaded 54227909 bytes. 01:24:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EE25Ah43Tq2wB9-VWI1O1A/artifacts/public/build/target.tar.bz2 01:24:06 INFO - mkdir: /builds/slave/test/properties 01:24:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:24:06 INFO - Writing to file /builds/slave/test/properties/build_url 01:24:06 INFO - Contents: 01:24:06 INFO - build_url:https://queue.taskcluster.net/v1/task/EE25Ah43Tq2wB9-VWI1O1A/artifacts/public/build/target.tar.bz2 01:24:06 INFO - Running post-action listener: _resource_record_post_action 01:24:06 INFO - Running post-action listener: set_extra_try_arguments 01:24:06 INFO - [mozharness: 2017-05-27 08:24:06.775867Z] Finished download-and-extract step (success) 01:24:06 INFO - [mozharness: 2017-05-27 08:24:06.775965Z] Running populate-webroot step. 01:24:06 INFO - Running pre-action listener: _resource_record_pre_action 01:24:06 INFO - Running main action method: populate_webroot 01:24:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:24:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:24:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:24:06 INFO - '--tppagecycles', 01:24:06 INFO - '7'], 01:24:06 INFO - 'tests': ['tsvgm']}}, 01:24:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:24:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:24:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:24:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:24:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:24:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:24:06 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:24:06 INFO - 'talos_options': ['--disable-e10s'], 01:24:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:24:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:24:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:24:06 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:24:06 INFO - 'talos_options': ['--disable-e10s'], 01:24:06 INFO - 'tests': ['damp', 'tps']}, 01:24:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:24:06 INFO - 'tests': ['damp', 'tps']}, 01:24:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:24:06 INFO - 'tests': ['dromaeo_dom']}, 01:24:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:24:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:24:06 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 01:24:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 01:24:06 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 01:24:06 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 01:24:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:24:06 INFO - 'tests': ['a11yr', 01:24:06 INFO - 'ts_paint', 01:24:06 INFO - 'tpaint', 01:24:06 INFO - 'sessionrestore', 01:24:06 INFO - 'sessionrestore_no_auto_restore', 01:24:06 INFO - 'tabpaint']}, 01:24:06 INFO - 'other-e10s': {'tests': ['a11yr', 01:24:06 INFO - 'ts_paint', 01:24:06 INFO - 'tpaint', 01:24:06 INFO - 'sessionrestore', 01:24:06 INFO - 'sessionrestore_no_auto_restore', 01:24:06 INFO - 'tabpaint']}, 01:24:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:24:06 INFO - 'ts_paint', 01:24:06 INFO - 'tpaint', 01:24:06 INFO - 'sessionrestore', 01:24:06 INFO - 'sessionrestore_no_auto_restore', 01:24:06 INFO - 'tabpaint']}, 01:24:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:24:06 INFO - 'ts_paint', 01:24:06 INFO - 'tpaint', 01:24:06 INFO - 'sessionrestore', 01:24:06 INFO - 'sessionrestore_no_auto_restore', 01:24:06 INFO - 'tabpaint']}, 01:24:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:24:06 INFO - 'tests': ['a11yr', 01:24:06 INFO - 'ts_paint', 01:24:06 INFO - 'tpaint', 01:24:06 INFO - 'sessionrestore', 01:24:06 INFO - 'sessionrestore_no_auto_restore', 01:24:06 INFO - 'tabpaint']}, 01:24:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:24:06 INFO - 'tests': ['a11yr', 01:24:06 INFO - 'ts_paint', 01:24:06 INFO - 'tpaint', 01:24:06 INFO - 'sessionrestore', 01:24:06 INFO - 'sessionrestore_no_auto_restore', 01:24:06 INFO - 'tabpaint']}, 01:24:06 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 01:24:06 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 01:24:06 INFO - 'bloom_basic_ref']}, 01:24:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:24:06 INFO - 'tests': ['tsvgx', 01:24:06 INFO - 'tsvgr_opacity', 01:24:06 INFO - 'tart', 01:24:06 INFO - 'tscrollx', 01:24:06 INFO - 'cart', 01:24:06 INFO - 'tsvg_static']}, 01:24:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:24:06 INFO - 'tsvgr_opacity', 01:24:06 INFO - 'tart', 01:24:06 INFO - 'tscrollx', 01:24:06 INFO - 'cart', 01:24:06 INFO - 'tsvg_static']}, 01:24:06 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:24:06 INFO - 'talos_options': ['--disable-e10s'], 01:24:06 INFO - 'tests': ['tp5o']}, 01:24:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:24:06 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:24:06 INFO - 'talos_options': ['--disable-e10s', 01:24:06 INFO - '--xperf_path', 01:24:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:24:06 INFO - 'tests': ['tp5n']}, 01:24:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:24:06 INFO - 'talos_options': ['--xperf_path', 01:24:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:24:06 INFO - 'tests': ['tp5n']}}, 01:24:06 INFO - 'talos.zip': {'path': '', 01:24:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:24:06 INFO - Running post-action listener: _resource_record_post_action 01:24:06 INFO - [mozharness: 2017-05-27 08:24:06.789972Z] Finished populate-webroot step (success) 01:24:06 INFO - [mozharness: 2017-05-27 08:24:06.790061Z] Running create-virtualenv step. 01:24:06 INFO - Running pre-action listener: _resource_record_pre_action 01:24:06 INFO - Running main action method: create_virtualenv 01:24:06 INFO - Creating virtualenv /builds/slave/test/build/venv 01:24:06 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 01:24:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:24:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:24:06 INFO - Using real prefix '/usr' 01:24:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:24:07 INFO - Installing distribute.............................................................................................................................................................................................done. 01:24:09 INFO - Installing pip.................done. 01:24:09 INFO - Return code: 0 01:24:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:24:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:24:09 INFO - Reading from file tmpfile_stdout 01:24:09 INFO - Output received: 01:24:09 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) 01:24:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:24:09 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')]} 01:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:09 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')]} 01:24:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:09 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 0xd9f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11125c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110f7a0>, '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 0x11106a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1110b30>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1495858813.155868-861733865', '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 01:24:09 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 01:24:09 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 01:24:09 INFO - Using env: {'DISPLAY': ':0', 01:24:09 INFO - 'HOME': '/home/cltbld', 01:24:09 INFO - 'LANG': 'en_US.UTF-8', 01:24:09 INFO - 'LANGUAGE': 'en_US:en', 01:24:09 INFO - 'LOGNAME': 'cltbld', 01:24:09 INFO - 'MAIL': '/var/mail/cltbld', 01:24:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:09 INFO - 'MOZ_NO_REMOTE': '1', 01:24:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:09 INFO - 'NO_EM_RESTART': '1', 01:24:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:09 INFO - 'PWD': '/builds/slave/test', 01:24:09 INFO - 'SHELL': '/bin/bash', 01:24:09 INFO - 'SHLVL': '1', 01:24:09 INFO - 'TERM': 'linux', 01:24:09 INFO - 'TMOUT': '86400', 01:24:09 INFO - 'USER': 'cltbld', 01:24:09 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1495858813.155868-861733865', 01:24:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:09 INFO - '_': '/tools/buildbot/bin/python'} 01:24:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:09 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 01:24:09 INFO - Cleaning up... 01:24:09 INFO - Return code: 0 01:24:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:24:09 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')]} 01:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:09 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')]} 01:24:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:09 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 0xd9f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11125c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110f7a0>, '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 0x11106a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1110b30>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1495858813.155868-861733865', '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 01:24:09 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 01:24:09 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 01:24:09 INFO - Using env: {'DISPLAY': ':0', 01:24:09 INFO - 'HOME': '/home/cltbld', 01:24:09 INFO - 'LANG': 'en_US.UTF-8', 01:24:09 INFO - 'LANGUAGE': 'en_US:en', 01:24:09 INFO - 'LOGNAME': 'cltbld', 01:24:09 INFO - 'MAIL': '/var/mail/cltbld', 01:24:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:09 INFO - 'MOZ_NO_REMOTE': '1', 01:24:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:09 INFO - 'NO_EM_RESTART': '1', 01:24:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:09 INFO - 'PWD': '/builds/slave/test', 01:24:09 INFO - 'SHELL': '/bin/bash', 01:24:09 INFO - 'SHLVL': '1', 01:24:09 INFO - 'TERM': 'linux', 01:24:09 INFO - 'TMOUT': '86400', 01:24:09 INFO - 'USER': 'cltbld', 01:24:09 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1495858813.155868-861733865', 01:24:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:09 INFO - '_': '/tools/buildbot/bin/python'} 01:24:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:10 INFO - Downloading/unpacking psutil>=3.1.1 01:24:10 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 01:24:10 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 01:24:10 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 01:24:10 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 01:24:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:24:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:24:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:24:11 INFO - Installing collected packages: psutil 01:24:11 INFO - Running setup.py install for psutil 01:24:11 INFO - building 'psutil._psutil_linux' extension 01:24:11 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 01:24:11 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 01:24:11 INFO - building 'psutil._psutil_posix' extension 01:24:11 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 01:24:11 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 01:24:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:24:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:24:11 INFO - Successfully installed psutil 01:24:11 INFO - Cleaning up... 01:24:11 INFO - Return code: 0 01:24:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:24: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')]} 01:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24: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')]} 01:24:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:11 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 0xd9f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11125c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110f7a0>, '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 0x11106a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1110b30>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1495858813.155868-861733865', '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 01:24:11 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 01:24:11 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 01:24:11 INFO - Using env: {'DISPLAY': ':0', 01:24:11 INFO - 'HOME': '/home/cltbld', 01:24:11 INFO - 'LANG': 'en_US.UTF-8', 01:24:11 INFO - 'LANGUAGE': 'en_US:en', 01:24:11 INFO - 'LOGNAME': 'cltbld', 01:24:11 INFO - 'MAIL': '/var/mail/cltbld', 01:24:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:11 INFO - 'MOZ_NO_REMOTE': '1', 01:24:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:11 INFO - 'NO_EM_RESTART': '1', 01:24:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:11 INFO - 'PWD': '/builds/slave/test', 01:24:11 INFO - 'SHELL': '/bin/bash', 01:24:11 INFO - 'SHLVL': '1', 01:24:11 INFO - 'TERM': 'linux', 01:24:11 INFO - 'TMOUT': '86400', 01:24:11 INFO - 'USER': 'cltbld', 01:24:11 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1495858813.155868-861733865', 01:24:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:11 INFO - '_': '/tools/buildbot/bin/python'} 01:24:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:24:11 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 01:24:11 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 01:24:11 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 01:24:11 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 01:24:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:24:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:24:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:24:13 INFO - Installing collected packages: mozsystemmonitor 01:24:13 INFO - Running setup.py install for mozsystemmonitor 01:24:13 INFO - Successfully installed mozsystemmonitor 01:24:13 INFO - Cleaning up... 01:24:13 INFO - Return code: 0 01:24:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:24:13 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')]} 01:24:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:13 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')]} 01:24:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:13 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 0xd9f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11125c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110f7a0>, '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 0x11106a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1110b30>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1495858813.155868-861733865', '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 01:24:13 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 01:24:13 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 01:24:13 INFO - Using env: {'DISPLAY': ':0', 01:24:13 INFO - 'HOME': '/home/cltbld', 01:24:13 INFO - 'LANG': 'en_US.UTF-8', 01:24:13 INFO - 'LANGUAGE': 'en_US:en', 01:24:13 INFO - 'LOGNAME': 'cltbld', 01:24:13 INFO - 'MAIL': '/var/mail/cltbld', 01:24:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:13 INFO - 'MOZ_NO_REMOTE': '1', 01:24:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:13 INFO - 'NO_EM_RESTART': '1', 01:24:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:13 INFO - 'PWD': '/builds/slave/test', 01:24:13 INFO - 'SHELL': '/bin/bash', 01:24:13 INFO - 'SHLVL': '1', 01:24:13 INFO - 'TERM': 'linux', 01:24:13 INFO - 'TMOUT': '86400', 01:24:13 INFO - 'USER': 'cltbld', 01:24:13 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1495858813.155868-861733865', 01:24:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:13 INFO - '_': '/tools/buildbot/bin/python'} 01:24:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:13 INFO - Downloading/unpacking jsonschema==2.5.1 01:24:13 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 01:24:13 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 01:24:13 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 01:24:13 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 01:24:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:24:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:24:14 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 01:24:14 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 01:24:14 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 01:24:14 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 01:24:14 INFO - Downloading functools32-3.2.3-2.tar.gz 01:24:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:24:14 INFO - warning: no files found matching '*.txt' 01:24:14 INFO - no previously-included directories found matching 'build' 01:24:14 INFO - no previously-included directories found matching 'dist' 01:24:14 INFO - no previously-included directories found matching '.git*' 01:24:14 INFO - Installing collected packages: jsonschema, functools32 01:24:14 INFO - Running setup.py install for functools32 01:24:14 INFO - warning: no files found matching '*.txt' 01:24:14 INFO - no previously-included directories found matching 'build' 01:24:14 INFO - no previously-included directories found matching 'dist' 01:24:14 INFO - no previously-included directories found matching '.git*' 01:24:14 INFO - Successfully installed jsonschema functools32 01:24:14 INFO - Cleaning up... 01:24:14 INFO - Return code: 0 01:24:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:24:14 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')]} 01:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:14 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')]} 01:24:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:14 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 0xd9f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11125c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110f7a0>, '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 0x11106a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1110b30>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1495858813.155868-861733865', '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 01:24:14 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 01:24:14 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 01:24:14 INFO - Using env: {'DISPLAY': ':0', 01:24:14 INFO - 'HOME': '/home/cltbld', 01:24:14 INFO - 'LANG': 'en_US.UTF-8', 01:24:14 INFO - 'LANGUAGE': 'en_US:en', 01:24:14 INFO - 'LOGNAME': 'cltbld', 01:24:14 INFO - 'MAIL': '/var/mail/cltbld', 01:24:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:14 INFO - 'MOZ_NO_REMOTE': '1', 01:24:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:14 INFO - 'NO_EM_RESTART': '1', 01:24:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:14 INFO - 'PWD': '/builds/slave/test', 01:24:14 INFO - 'SHELL': '/bin/bash', 01:24:14 INFO - 'SHLVL': '1', 01:24:14 INFO - 'TERM': 'linux', 01:24:14 INFO - 'TMOUT': '86400', 01:24:14 INFO - 'USER': 'cltbld', 01:24:14 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1495858813.155868-861733865', 01:24:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:14 INFO - '_': '/tools/buildbot/bin/python'} 01:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:24:15 INFO - Cleaning up... 01:24:15 INFO - Return code: 0 01:24:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:15 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 0xd9f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11125c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110f7a0>, '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 0x11106a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1110b30>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1495858813.155868-861733865', '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 01:24:15 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 01:24:15 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 01:24:15 INFO - Using env: {'DISPLAY': ':0', 01:24:15 INFO - 'HOME': '/home/cltbld', 01:24:15 INFO - 'LANG': 'en_US.UTF-8', 01:24:15 INFO - 'LANGUAGE': 'en_US:en', 01:24:15 INFO - 'LOGNAME': 'cltbld', 01:24:15 INFO - 'MAIL': '/var/mail/cltbld', 01:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:15 INFO - 'MOZ_NO_REMOTE': '1', 01:24:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:15 INFO - 'NO_EM_RESTART': '1', 01:24:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:15 INFO - 'PWD': '/builds/slave/test', 01:24:15 INFO - 'SHELL': '/bin/bash', 01:24:15 INFO - 'SHLVL': '1', 01:24:15 INFO - 'TERM': 'linux', 01:24:15 INFO - 'TMOUT': '86400', 01:24:15 INFO - 'USER': 'cltbld', 01:24:15 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1495858813.155868-861733865', 01:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:15 INFO - '_': '/tools/buildbot/bin/python'} 01:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:15 INFO - Downloading/unpacking blobuploader==1.2.4 01:24:15 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 01:24:15 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 01:24:15 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 01:24:15 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 01:24:16 INFO - Downloading blobuploader-1.2.4.tar.gz 01:24:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:24:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:24:16 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 01:24:16 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 01:24:16 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 01:24:16 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 01:24:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:24:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:24:17 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 01:24:17 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 01:24:17 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 01:24:17 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 01:24:17 INFO - Downloading docopt-0.6.1.tar.gz 01:24:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:24:17 INFO - Installing collected packages: blobuploader, requests, docopt 01:24:17 INFO - Running setup.py install for blobuploader 01:24:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:24:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:24:17 INFO - Running setup.py install for requests 01:24:17 INFO - Running setup.py install for docopt 01:24:17 INFO - Successfully installed blobuploader requests docopt 01:24:17 INFO - Cleaning up... 01:24:17 INFO - Return code: 0 01:24:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:24:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:24:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:17 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 0xd9f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11125c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110f7a0>, '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 0x11106a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1110b30>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1495858813.155868-861733865', '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 01:24:17 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 01:24:17 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 01:24:17 INFO - Using env: {'DISPLAY': ':0', 01:24:17 INFO - 'HOME': '/home/cltbld', 01:24:17 INFO - 'LANG': 'en_US.UTF-8', 01:24:17 INFO - 'LANGUAGE': 'en_US:en', 01:24:17 INFO - 'LOGNAME': 'cltbld', 01:24:17 INFO - 'MAIL': '/var/mail/cltbld', 01:24:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:17 INFO - 'MOZ_NO_REMOTE': '1', 01:24:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:17 INFO - 'NO_EM_RESTART': '1', 01:24:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:17 INFO - 'PWD': '/builds/slave/test', 01:24:17 INFO - 'SHELL': '/bin/bash', 01:24:17 INFO - 'SHLVL': '1', 01:24:17 INFO - 'TERM': 'linux', 01:24:17 INFO - 'TMOUT': '86400', 01:24:17 INFO - 'USER': 'cltbld', 01:24:17 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1495858813.155868-861733865', 01:24:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:17 INFO - '_': '/tools/buildbot/bin/python'} 01:24:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:24:18 INFO - Running setup.py (path:/tmp/pip-NQ7DkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:24:18 INFO - Running setup.py (path:/tmp/pip-RAzWOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:24:18 INFO - Running setup.py (path:/tmp/pip-b5DIfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:24:18 INFO - Running setup.py (path:/tmp/pip-RirRvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:24:18 INFO - Running setup.py (path:/tmp/pip-rSFLkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:24:18 INFO - Running setup.py (path:/tmp/pip-MRoAay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:24:18 INFO - Running setup.py (path:/tmp/pip-OWJ_JB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:24:18 INFO - Running setup.py (path:/tmp/pip-zC_Ina-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:24:18 INFO - Running setup.py (path:/tmp/pip-cHqTQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:24:18 INFO - Running setup.py (path:/tmp/pip-Vb3NvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:24:18 INFO - Running setup.py (path:/tmp/pip-3aqtv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:24:18 INFO - Running setup.py (path:/tmp/pip-64akFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:24:18 INFO - Running setup.py (path:/tmp/pip-a6lAwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:24:19 INFO - Running setup.py (path:/tmp/pip-_TiwZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:24:19 INFO - Running setup.py (path:/tmp/pip-n4_REc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:24:19 INFO - Running setup.py (path:/tmp/pip-eTowLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:24:19 INFO - Running setup.py (path:/tmp/pip-eTkWD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:24:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:24:19 INFO - Running setup.py install for manifestparser 01:24:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:24:19 INFO - Running setup.py install for mozcrash 01:24:19 INFO - Running setup.py install for mozdebug 01:24:19 INFO - Running setup.py install for mozdevice 01:24:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:24:19 INFO - Running setup.py install for mozfile 01:24:19 INFO - Running setup.py install for mozhttpd 01:24:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:24:19 INFO - Running setup.py install for mozinfo 01:24:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:24:20 INFO - Running setup.py install for mozInstall 01:24:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:24:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:24:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:24:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:24:20 INFO - Running setup.py install for mozleak 01:24:20 INFO - Running setup.py install for mozlog 01:24:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:24:20 INFO - Running setup.py install for moznetwork 01:24:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:24:20 INFO - Running setup.py install for mozprocess 01:24:20 INFO - Running setup.py install for mozprofile 01:24:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:24:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:24:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:24:20 INFO - Running setup.py install for mozrunner 01:24:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:24:20 INFO - Running setup.py install for mozscreenshot 01:24:20 INFO - Running setup.py install for moztest 01:24:20 INFO - Running setup.py install for mozversion 01:24:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:24:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:24:21 INFO - Cleaning up... 01:24:21 INFO - Return code: 0 01:24:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:24:21 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')]} 01:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:21 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')]} 01:24:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:21 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 0xd9f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11125c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110f7a0>, '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 0x11106a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1110b30>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1495858813.155868-861733865', '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 01:24:21 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 01:24:21 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 01:24:21 INFO - Using env: {'DISPLAY': ':0', 01:24:21 INFO - 'HOME': '/home/cltbld', 01:24:21 INFO - 'LANG': 'en_US.UTF-8', 01:24:21 INFO - 'LANGUAGE': 'en_US:en', 01:24:21 INFO - 'LOGNAME': 'cltbld', 01:24:21 INFO - 'MAIL': '/var/mail/cltbld', 01:24:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:21 INFO - 'MOZ_NO_REMOTE': '1', 01:24:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:21 INFO - 'NO_EM_RESTART': '1', 01:24:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:21 INFO - 'PWD': '/builds/slave/test', 01:24:21 INFO - 'SHELL': '/bin/bash', 01:24:21 INFO - 'SHLVL': '1', 01:24:21 INFO - 'TERM': 'linux', 01:24:21 INFO - 'TMOUT': '86400', 01:24:21 INFO - 'USER': 'cltbld', 01:24:21 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1495858813.155868-861733865', 01:24:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:21 INFO - '_': '/tools/buildbot/bin/python'} 01:24:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:24:21 INFO - Running setup.py (path:/tmp/pip-7gbN6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:24:21 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)) 01:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:24:21 INFO - Running setup.py (path:/tmp/pip-XFDqwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:24:21 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)) 01:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:24:21 INFO - Running setup.py (path:/tmp/pip-tGdkC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:24:21 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)) 01:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:24:21 INFO - Running setup.py (path:/tmp/pip-c66RCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:24:21 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)) 01:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:24:21 INFO - Running setup.py (path:/tmp/pip-vX9qLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:24:21 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)) 01:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:24:21 INFO - Running setup.py (path:/tmp/pip-UYk9VT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:24:21 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)) 01:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:24:21 INFO - Running setup.py (path:/tmp/pip-nTvXFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:24:21 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)) 01:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:24:21 INFO - Running setup.py (path:/tmp/pip-Ngpbg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:24:21 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)) 01:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:24:21 INFO - Running setup.py (path:/tmp/pip-GP5zDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:24:21 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)) 01:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:24:21 INFO - Running setup.py (path:/tmp/pip-JBxTCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:24:22 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)) 01:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:24:22 INFO - Running setup.py (path:/tmp/pip-VUPh1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:24:22 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)) 01:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:24:22 INFO - Running setup.py (path:/tmp/pip-Trb7yV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:24:22 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)) 01:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:24:22 INFO - Running setup.py (path:/tmp/pip-qti1Nk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:24:22 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)) 01:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:24:22 INFO - Running setup.py (path:/tmp/pip-G_1Ufx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:24:22 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)) 01:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:24:22 INFO - Running setup.py (path:/tmp/pip-tdGzYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:24:22 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)) 01:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:24:22 INFO - Running setup.py (path:/tmp/pip-EKOBHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:24:22 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)) 01:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:24:22 INFO - Running setup.py (path:/tmp/pip-Okcbmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:24:22 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)) 01:24:22 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)) 01:24:22 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)) 01:24:22 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)) 01:24:22 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)) 01:24:22 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)) 01:24:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:23 INFO - Downloading blessings-1.6.tar.gz 01:24:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:24:23 INFO - Installing collected packages: blessings 01:24:23 INFO - Running setup.py install for blessings 01:24:24 INFO - Successfully installed blessings 01:24:24 INFO - Cleaning up... 01:24:24 INFO - Return code: 0 01:24:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:24:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:24:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:24:24 INFO - Reading from file tmpfile_stdout 01:24:24 INFO - Current package versions: 01:24:24 INFO - argparse == 1.2.1 01:24:24 INFO - blessings == 1.6 01:24:24 INFO - blobuploader == 1.2.4 01:24:24 INFO - docopt == 0.6.1 01:24:24 INFO - functools32 == 3.2.3-2 01:24:24 INFO - jsonschema == 2.5.1 01:24:24 INFO - manifestparser == 1.1 01:24:24 INFO - mozInstall == 1.12 01:24:24 INFO - mozcrash == 1.0 01:24:24 INFO - mozdebug == 0.1 01:24:24 INFO - mozdevice == 0.51 01:24:24 INFO - mozfile == 1.2 01:24:24 INFO - mozhttpd == 0.7 01:24:24 INFO - mozinfo == 0.9 01:24:24 INFO - mozleak == 0.1 01:24:24 INFO - mozlog == 3.4 01:24:24 INFO - moznetwork == 0.27 01:24:24 INFO - mozprocess == 0.25 01:24:24 INFO - mozprofile == 0.28 01:24:24 INFO - mozrunner == 6.13 01:24:24 INFO - mozscreenshot == 0.1 01:24:24 INFO - mozsystemmonitor == 0.3 01:24:24 INFO - moztest == 0.8 01:24:24 INFO - mozversion == 1.4 01:24:24 INFO - psutil == 3.1.1 01:24:24 INFO - requests == 1.2.3 01:24:24 INFO - wsgiref == 0.1.2 01:24:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:24:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:24:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:24:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:24 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 0xd9f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11125c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110f7a0>, '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 0x11106a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1110b30>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1495858813.155868-861733865', '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 01:24:24 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 01:24:24 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 01:24:24 INFO - Using env: {'DISPLAY': ':0', 01:24:24 INFO - 'HOME': '/home/cltbld', 01:24:24 INFO - 'LANG': 'en_US.UTF-8', 01:24:24 INFO - 'LANGUAGE': 'en_US:en', 01:24:24 INFO - 'LOGNAME': 'cltbld', 01:24:24 INFO - 'MAIL': '/var/mail/cltbld', 01:24:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:24 INFO - 'MOZ_NO_REMOTE': '1', 01:24:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:24 INFO - 'NO_EM_RESTART': '1', 01:24:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:24 INFO - 'PWD': '/builds/slave/test', 01:24:24 INFO - 'SHELL': '/bin/bash', 01:24:24 INFO - 'SHLVL': '1', 01:24:24 INFO - 'TERM': 'linux', 01:24:24 INFO - 'TMOUT': '86400', 01:24:24 INFO - 'USER': 'cltbld', 01:24:24 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1495858813.155868-861733865', 01:24:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:24 INFO - '_': '/tools/buildbot/bin/python'} 01:24:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:24 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)) 01:24:24 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)) 01:24:24 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)) 01:24:24 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)) 01:24:24 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)) 01:24:24 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)) 01:24:24 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)) 01:24:24 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)) 01:24:24 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)) 01:24:24 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 01:24:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:25 INFO - Downloading marionette_driver-1.4.0.tar.gz 01:24:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 01:24:25 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)) 01:24:25 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)) 01:24:25 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)) 01:24:25 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)) 01:24:25 INFO - Installing collected packages: marionette-driver 01:24:25 INFO - Running setup.py install for marionette-driver 01:24:25 INFO - Successfully installed marionette-driver 01:24:25 INFO - Cleaning up... 01:24:26 INFO - Return code: 0 01:24:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:24:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd9f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11125c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110f7a0>, '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 0x11106a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1110b30>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1495858813.155868-861733865', '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 01:24:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:24:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:24:26 INFO - Using env: {'DISPLAY': ':0', 01:24:26 INFO - 'HOME': '/home/cltbld', 01:24:26 INFO - 'LANG': 'en_US.UTF-8', 01:24:26 INFO - 'LANGUAGE': 'en_US:en', 01:24:26 INFO - 'LOGNAME': 'cltbld', 01:24:26 INFO - 'MAIL': '/var/mail/cltbld', 01:24:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:26 INFO - 'MOZ_NO_REMOTE': '1', 01:24:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:26 INFO - 'NO_EM_RESTART': '1', 01:24:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:26 INFO - 'PWD': '/builds/slave/test', 01:24:26 INFO - 'SHELL': '/bin/bash', 01:24:26 INFO - 'SHLVL': '1', 01:24:26 INFO - 'TERM': 'linux', 01:24:26 INFO - 'TMOUT': '86400', 01:24:26 INFO - 'USER': 'cltbld', 01:24:26 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1495858813.155868-861733865', 01:24:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:26 INFO - '_': '/tools/buildbot/bin/python'} 01:24:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:24:26 INFO - Cleaning up... 01:24:26 INFO - Return code: 0 01:24:26 INFO - Running post-action listener: _resource_record_post_action 01:24:26 INFO - Running post-action listener: _start_resource_monitoring 01:24:26 INFO - Starting resource monitoring. 01:24:26 INFO - [mozharness: 2017-05-27 08:24:26.300625Z] Finished create-virtualenv step (success) 01:24:26 INFO - [mozharness: 2017-05-27 08:24:26.301084Z] Running install step. 01:24:26 INFO - Running pre-action listener: _resource_record_pre_action 01:24:26 INFO - Running main action method: install 01:24:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:24:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:24:26 INFO - Reading from file tmpfile_stdout 01:24:26 INFO - Detecting whether we're running mozinstall >=1.0... 01:24:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:24:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:24:26 INFO - Reading from file tmpfile_stdout 01:24:26 INFO - Output received: 01:24:26 INFO - Usage: mozinstall [options] installer 01:24:26 INFO - Options: 01:24:26 INFO - -h, --help show this help message and exit 01:24:26 INFO - -d DEST, --destination=DEST 01:24:26 INFO - Directory to install application into. [default: 01:24:26 INFO - "/builds/slave/test"] 01:24:26 INFO - --app=APP Application being installed. [default: firefox] 01:24:26 INFO - mkdir: /builds/slave/test/build/application 01:24:26 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'] 01:24:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 01:24:42 INFO - Reading from file tmpfile_stdout 01:24:42 INFO - Output received: 01:24:42 INFO - /builds/slave/test/build/application/firefox/firefox 01:24:42 INFO - Running post-action listener: _resource_record_post_action 01:24:42 INFO - [mozharness: 2017-05-27 08:24:42.140117Z] Finished install step (success) 01:24:42 INFO - [mozharness: 2017-05-27 08:24:42.140269Z] Running run-tests step. 01:24:42 INFO - Running pre-action listener: _resource_record_pre_action 01:24:42 INFO - Running main action method: run_tests 01:24:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:24:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:24:42 INFO - Python 2.7.3 01:24:42 INFO - Return code: 0 01:24:42 INFO - grabbing minidump binary from tooltool 01:24: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')]} 01:24:42 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 0x110f7a0>, '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 0x11106a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1110b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:24:42 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 01:24:42 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 01:24:42 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 01:24:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:24:42 INFO - Return code: 0 01:24:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:24:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:24:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:24:42 INFO - ENV: RUST_BACKTRACE is now 1 01:24:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:24:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:24:42 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/EE25Ah43Tq2wB9-VWI1O1A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 01:24:42 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/EE25Ah43Tq2wB9-VWI1O1A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 01:24:42 INFO - Using env: {'DISPLAY': ':0', 01:24:42 INFO - 'HOME': '/home/cltbld', 01:24:42 INFO - 'LANG': 'en_US.UTF-8', 01:24:42 INFO - 'LANGUAGE': 'en_US:en', 01:24:42 INFO - 'LOGNAME': 'cltbld', 01:24:42 INFO - 'MAIL': '/var/mail/cltbld', 01:24:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:24:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:24:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:42 INFO - 'MOZ_NO_REMOTE': '1', 01:24:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:24:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:42 INFO - 'NO_EM_RESTART': '1', 01:24:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:42 INFO - 'PWD': '/builds/slave/test', 01:24:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:24:42 INFO - 'RUST_BACKTRACE': '1', 01:24:42 INFO - 'SHELL': '/bin/bash', 01:24:42 INFO - 'SHLVL': '1', 01:24:42 INFO - 'TERM': 'linux', 01:24:42 INFO - 'TMOUT': '86400', 01:24:42 INFO - 'USER': 'cltbld', 01:24:42 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1495858813.155868-861733865', 01:24:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:42 INFO - '_': '/tools/buildbot/bin/python'} 01:24:42 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/EE25Ah43Tq2wB9-VWI1O1A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 01:24:42 INFO - mozversion application_buildid: 20170527075057 01:24:42 INFO - mozversion application_changeset: 1c1bf54915bbf8cda82dbf7985e87b1c0ff30e4c 01:24:42 INFO - mozversion application_display_name: Nightly 01:24:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:24:42 INFO - mozversion application_name: Firefox 01:24:42 INFO - mozversion application_remotingname: firefox 01:24:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 01:24:42 INFO - mozversion application_vendor: Mozilla 01:24:42 INFO - mozversion application_version: 55.0a1 01:24:42 INFO - mozversion platform_buildid: 20170527075057 01:24:42 INFO - mozversion platform_changeset: 1c1bf54915bbf8cda82dbf7985e87b1c0ff30e4c 01:24:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 01:24:42 INFO - mozversion platform_version: 55.0a1 01:24:42 INFO - using testdate: 1495873482 01:24:42 INFO - actual date: 1495873482 01:24:42 INFO - starting webserver on 'localhost:37553' 01:24:42 INFO - SUITE-START | Running 2 tests 01:24:42 INFO - TEST-START | dromaeo_css 01:24:42 INFO - operating with platform_type : linux_ 01:24:42 INFO - Initialising browser for dromaeo_css test... 01:24:42 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37553/getInfo.html -profile /tmp/tmp8ynbgK/profile 01:24:42 INFO - TEST-INFO | started process 19668 (/builds/slave/test/build/application/firefox/firefox http://localhost:37553/getInfo.html) 01:25:16 INFO - TEST-INFO | 19668: killed by SIGTERM 01:25:16 INFO - Browser initialized. 01:25:16 INFO - Running cycle 1/1 for dromaeo_css test... 01:25:16 INFO - TEST-INFO | started process 19866 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8ynbgK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:25:28 INFO - PID 19866 | RSS: Main: 169869312 01:25:28 INFO - PID 19866 | 01:28:33 INFO - PID 19866 | Cycle 1(1): loaded http://localhost:37553/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37553/tests/dromaeo/cssquery-ext.html) 01:28:34 INFO - PID 19866 | RSS: Main: 170479616 01:28:34 INFO - PID 19866 | 01:31:36 INFO - PID 19866 | Cycle 1(1): loaded http://localhost:37553/tests/dromaeo/cssquery-ext.html (next: http://localhost:37553/tests/dromaeo/cssquery-jquery.html) 01:31:36 INFO - PID 19866 | RSS: Main: 174559232 01:31:36 INFO - PID 19866 | 01:34:38 INFO - PID 19866 | Cycle 1(1): loaded http://localhost:37553/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37553/tests/dromaeo/cssquery-mootools.html) 01:34:39 INFO - PID 19866 | RSS: Main: 170692608 01:34:39 INFO - PID 19866 | 01:37:40 INFO - PID 19866 | Cycle 1(1): loaded http://localhost:37553/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37553/tests/dromaeo/cssquery-prototype.html) 01:37:41 INFO - PID 19866 | RSS: Main: 177410048 01:37:41 INFO - PID 19866 | 01:40:44 INFO - PID 19866 | Cycle 1(1): loaded http://localhost:37553/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37553/tests/dromaeo/cssquery-yui.html) 01:40:44 INFO - PID 19866 | RSS: Main: 174342144 01:40:44 INFO - PID 19866 | 01:43:46 INFO - PID 19866 | Cycle 1(1): loaded http://localhost:37553/tests/dromaeo/cssquery-yui.html (next: http://localhost:37553/tests/dromaeo/cssquery-dojo.html) 01:43:46 INFO - PID 19866 | RSS: Main: 172638208 01:43:46 INFO - PID 19866 | 01:43:46 INFO - PID 19866 | __start_tp_report 01:43:46 INFO - PID 19866 | _x_x_mozilla_page_load 01:43:46 INFO - PID 19866 | _x_x_mozilla_page_load_details 01:43:46 INFO - PID 19866 | |i|pagename|runs| 01:43:46 INFO - PID 19866 | |0;dojo.html;2714.755671989521;2744.84903330317;2763.0605594098015;2779.708130646281;2780.652418447694;5216.217567364897;5283.682979021261;5346.2515247865285;5356.741165826033;5379.435159308275;5262.210668399742;5309.495597918191;5321.920171197426;5355.973220133894;5408.4591540845895;4649.186392381337;4693.50718174591;4715.198416269225;4725.17309470843;4780.641451891105;4748.406449193851;4755.381800365965;4768.90462190756;4780;4788.233882578788;4660.091282199973;4677.134730074947;4713.952860471386;4720.622350211975;4777.761111944389;4739.336492890998;4746.169420351424;4747.311639812242;4808.350872632185;4813.229883218668;4690.226112691402;4716.9292460613115;4732.810687572493;4750.287456881495;4755.571998520115;5196.76614552346;5284.550813180885;5343.893122137574;5347.0909945309395;5379.892402151935;5696.3449203341315;5698.544116470673;5753.8561535961935;5761.567882408836;5775.16260142277;5768.74040668171;5783.479486846204;5789.884202315972;5802.825915222508;5839.474447299721;5267.26258323835;5422.349318081855;5426.403095659474;5426.70153141581;5427.0773968425465;5847.912281315784;5862.062070068769;5915.704214789243;5968.46283834457;6007.579469437185;5714.914276285859;5716.228309178291;5716.5140963017775;5716.885662286731;5774.48029677331;5667.971660141673;5778.017736984722;5801.448862358069;5817.970910145422;5824.213731146326;5594.1888426177975;5667.376588575254;5695.060315047971;5748.252727145445;5751.252337196138;5735.1970724098655;5747.3103227612955;5772.7690892363835;5798.478136967693;5808.5353171747;4775;4796.35249241348;4802.663813533089;4805.735684537384;4845.491223421561;3980.2238563480423;4081.5306239782212;4123.670106391482;4126.112885729583;4126.607972242692;4787.928181077286;4819.7108173509005;4884.07202631506;4896.902061958741;4906;5797.275340582427;5814.680192589363;5817.331006934172;5822.505087067562;5823.068309070529;4883.560479556857;4890.144224760653;4895.461499235082;4899.608031357483;4933.0380575788095;4971.676841005323;4977.278294647328;5001.649884508122;5046.62150338726;5050.570701490341;5339.46605339463;5344.171653393731;5347.465253474621;5351.652142610874;5391.514763671288;5566.944330556805;5642.85892852682;5654.293213348332;5690.146478028163;5792.797252096157;5234.476552344735;5242.921356179584;5263.394709608444;5338.97330513345;5366.275552800322;5525.530329922001;5693.4021927696995;5704.2014118024335;5709.22925405065;5710.172025056427;5720.170575266647;5751.511121554715;5764.740586673526;5863.2670916135485;5863.413658634103;5653.2085508028085;5654.604177707521;5661.122526008476;5662.631928924607;5691;5641.407652196624;5643.4920857121415;5647.040003199384;5648.039833228278;5656.490915817596;5394.109971854757;5482.122860342326;5482.616216864941;5509.449055094458;5541.2796336476;5680.091185410314;5693.8861222774485;5694.117411801178;5696.088625819849;5750.741216645345;5453.618246722692;5490.945090549043;5492.780288788564;5501.477359650827;5516.558675306046 01:43:46 INFO - PID 19866 | |1;ext.html;690.2200513419834;726.0670038999885;744.2297222374843;1110.0342701849388;1122.1976286954825;32172.83913580432;33367.83316083419;33389;33401.49897751536;33473.828416005446;35068.473972890366;35295.4705679415;35392.2921541569;35512.822435887785;35619.82190089052;6575.868482630344;6750.864982700343;6848.6918088686125;6987.021816945632;7006.509544331899;6660.733570657168;6736.326367363249;6738.8315292117595;6743.898841517381;6756.864862702743;6731.057651928734;6779.423748981342;6782.660866956657;6798;6798.286179951108;6730.932690673079;6743.089682892795;6745.224299205581;6750.291219421939;6778.254392016875;6542.4766018718865;6560.868782624369;6581.703823327962;6604.108445359863;6606.768763093269;31911;32091.839540802146;32316.676833231835;32353.838230808695;32392.35215295681;3003.3993201359817;3030.10611869499;3035.544668299751;3041.863116159778;3042.497987832005;24973.875130624412;25034.37414064663;25037.874810626014;25133.87433062823;25170.24489265325;2983.961579381733;3036.0436462514235;3046.558249053875;3051.908442746721;3082.1832214463184;144010.27994859958;145050;145624.27187864098;146162.26918865443;148813;38840.22319553593;38874.61125388766;38931;39022;39161.60838391637;40387;40719.38920916188;40869.75216363129;40904.18191636151;43622;12122.39388030595;12177.452014659362;12277.754444911052;12279.631611051684;12319.507219711291;9513.429194248367;9525.428474291564;9527.09492598202;9528.904710952802;9574.234061275081;12628.242305461701;12640.494380224687;12696.238225706487;12747.171433856769;12926.962163891478;5323.467653234723;5568.1091025435735;5569.192467092249;5574.58190635704;5623.381428042912;873.2315562305258;908.981820363589;916.2349438219028;923.8544205185656;958.2190514730472;20777.896110519654;20846.06192721301;21039.78960210409;21229.938503074784;21463.712177269415;995.124290624246;1000.1049061090283;1000.8748906386702;1013.5945621751358;1023.7952409518126;11000.724981875357;11474.426278686033;11480.827787583194;11497.425128743696;11635.127365447624;177703;178103;179320;179734;180138;40883;41118.588814112074;41169.58830411718;41329.38005929913;41452.1709565813;1214.4534959268365;1254.2411840836162;1257.1639859493334;1257.7798885195054;1261.4890969157507;19484.415467535997;19802.70295945533;20151.294704685264;20591.8970405153;21029.89485052565;29259.85370073136;36478.8176059118;37750.81124594469;37846.81076594599;37850.43224351582;162577;163703;164034;164324;164700;30187;30416.847915760278;30605.540916886708;30648.540271895494;30767.2308192297;35420;35732.82133589315;35805.46291805677;36142.63857361393;36284;27793;27994.16017519478;28199.15402537927;28448.146555603365;29337.413251735274;27303;27593.58609620817;27768.583471247544;28280;28899;31284;31294.53058204174;31381.215469613442;31445.685543144275;31489;26388.472230554897;27031.891332497016;27441.451170976867;27647;29014.854925725238;21879.671804922622;22701.772982269966;22723;22784.88607557018;22960.19639312616 01:43:46 INFO - PID 19866 | |2;jquery.html;398.13604478282144;411.72825934882985;414.5936981757876;425.24731225730454;435.3687153627241;17349.566260843487;17388.21753021114;17957.551061223443;18062.18720157593;18073.7288940666;18125.546861328472;18306.725399119023;18427.078646067675;19102.61794764104;19266.71099933502;5390.8921821563545;5397.190421436777;5633.126865335879;5639.661620302774;5641.605087643867;5321.733913304339;5412.07994640912;5438.401775804658;5445.782168713266;5456.345238571377;5401.70290634015;5403.729813509329;5405.783768649269;5414.8917021659545;5432.429594892519;5306.469353064701;5358.678479291236;5425.538829199523;5432.13085906257;5468.945310546923;4899.975500122512;4915.3364295819965;4922.384701912261;4931.7040977541465;4933.333999910002;21348.252811151535;21770.673439898415;21868.89065554678;21914.013869375918;22010.88994555033;1559.91420471874;1583.8732901367978;1587.1826009605063;1597.952061438147;1598.4964736108088;14496;14711.117332960057;14931.402743890232;15079.698406031928;15331.156786376745;1876.2963888541797;1911.8279354857991;1928.7492625958675;1937.457511896657;2011.225678113922;91946.54026729823;92705;93785.53107234488;95096;95199.52400237955;10691.198160138021;10924.563017479211;11018.614348497924;11151;11222.719432014102;14672;15150.848491515164;15195.92402038005;15340.693186136215;15368.462103826312;7342.375898048619;7489.962550187214;7557.5465472071855;7649.349805266615;7655.961720191475;6957.076907965779;6957.304269573002;7121.394681452031;7129.964350178216;7136.286371362822;6873.450123990169;6910.965445172843;6915.412189963909;6965.33829286217;7032.6132062736015;1932.8357089647538;1937.5931054478717;1954.6579348613936;1987.8807271563753;2099.5800839832095;840.1556435782122;876.5047748022474;878.7978764884112;887.5029983209423;907.6142639378238;17246.223919923632;17299.221535030953;17368.739468907977;17602.38391656286;18362;846.1876598465542;886.6763631274667;891.6121487153109;892.9866052009226;905.6694306578052;9329.30030247734;9816.361936474106;9880.110790028932;9889.456079915673;10068.697939061693;378383;383126;383445.9104749266;391083;391160;77406.22593774102;77583.22416775873;78207;78750.6062469684;78900.60549697214;1069.2622090757352;1073.9087177589836;1078.5092782783815;1086.8369744538224;1092.8524649172418;14550.636234094232;14735.26323683833;14858.702825943637;15070.924645377141;15501.534953951399;38473.230535389695;38759.41860872033;39701.801490993515;40976.79511602423;41138.79430602828;46613.533864660916;51852.22221666603;52389;53424;53489;7703.614819258903;7760.379169666526;7865.960670196612;8047.557384343917;8192.344612430872;11977.221480603734;12123.211991220542;12336.136470447342;12379.75240495203;12386;9592.568334425107;10301;10484.370937743759;10602.310849794738;10770;10362.844557331797;10534.209934254808;10623.840642390525;10647.840282395926;10685.786284274427;9653.662121825702;9725.562349694139;10053.949730251303;10463.476826158814;10499;7659.157492675913;7831.2560306770765;7859.253370929752;8095.595220239083;8161.224683655043;9955.104040636377;10019.398836069859;10055.245856560641;10351.741206469898;10469.162467002774 01:43:46 INFO - PID 19866 | |3;mootools.html;1290.5805613175717;1334.9466021359146;1356.545557238325;1357.9999999999993;1358.2122369025963;9983.30116891817;10268.691939241817;10452.529636166371;10468.68593942181;10777.56889724412;10533.26267161299;10690.091342235919;10709.732256693587;10710.518026688798;10729.463526823667;2089.508965393135;2137.1451419432274;2151.4943988162768;2154.892255387232;2160.3087012156116;2081.84386171037;2107.2729908181727;2113.0491278924546;2117.83057355412;2121.671140973144;2049.7130401743766;2080.2927004818357;2086.9791302087015;2088.446561661161;2095.1095784291615;2011.1653663729535;2030.5634288627941;2036.887971161593;2038.2458490358663;2044.5604195097976;2000.7399038125095;2061.360978096795;2065.9690104648294;2110.2719561751173;2118.50215199428;10280.588776448933;10311.896881031169;10345.637902673445;10352.58589656413;10396.948015259875;5554.1391084381985;5719.485246327808;5762.9135562966585;5764.971175144139;5770.365259821417;3263.4452143135723;3415.248645298055;3433.639467855889;3479.373712731707;3495.038864312309;1125.9211855170142;1126.6394753678826;1134.3364131982717;1140.7604403075281;1152.066825871047;14978.325975331136;15114.924425377912;15120.017198882037;15208.935374523788;15270.083794972226;4762.738049407247;4809.110314591811;4920.31115643803;4928.926066109011;4931.950680493221;10944.945275273572;11027.17296202788;11032.50353734084;11040.227184097197;11053;5520.613557051048;5620.718964051781;5623.971880140573;5624.6625202487985;5626.521745651666;5017.394433781155;5192.636515443883;5202.739863006835;5214.348206474191;5220.869478263074;3788;3878.3406820840523;3908.2769687607883;3928.724989250782;3961.623645753649;1085.1102096280974;1114.8049091409134;1119.3172164979355;1120.0983208517223;1121.6635009497281;691.8927566227243;714.3463730686468;719.1801346465035;725.5610355734705;737.2590546500733;5416.9729151353995;5451.64564303319;5474.151506516497;5542.39033706292;5636.887262254732;504.56607317706744;527.6992114494778;528.7514868012029;531.0149672357721;532.2362409941746;3424.931501369959;3685.5146660840524;3702.129999450127;3782.149016471272;3915.647591716759;12791.296478693761;13313.733725325439;13330.73338533224;13582.59252222435;13804.516841910485;13348.065635405428;13548.525801596898;13618.523351682643;13626.523071692443;13872.167669939634;7190.424766018706;7226.458015648847;7437.665305061285;7611.238876112345;7661.310482056641;5924.437178468039;6237.96881015592;6354.26925903527;6475.7733479328;6589.637569933508;11533.711657208636;12400.19398739079;12441.315727635067;12461.87538124607;12532.310722909962;11863.703407414883;11865.050795936477;11978.04175665962;12079.57721479744;12097.637070887888;8267.958660206661;8573.485590864568;8595.140485951355;8608.182222688834;8610.311175105851;9546.42721436716;9561;9615.74995250613;9617.855732164164;9636.132748052709;8199.344052475668;8401.243888050105;8472.661093556435;8542.871856922275;8641.135886411308;7927.960360198162;8033.8393232136195;8085.676572937252;8175.877361839458;8178.631961561625;7134.643267836691;7150.356467917913;7200.603966781878;7207.891881621885;7209.963950180216;5037.445880953019;5176.859438310895;5237.554807841376;5245.449227831023;5343;5202.375714914235;5203.765830537711;5235.712035838065;5297.629165958346;5353.732313384393 01:43:46 INFO - PID 19866 | |4;prototype.html;341.3343979240482;363.7462894409508;368.2469350178884;368.7289841966156;378.35112781579596;5553.278073850399;5571.749271282792;5620.241267428896;5631.352394474637;5657.179708942201;5482.369527504338;5519.9448005519935;5522.3649280332775;5530.5299049580835;5534.059209934311;4029.516458025041;4109.712320137592;4261.914761704772;4278.080212754257;4282.31482962726;4142.627163555279;4151.12826306476;4156.5635608261155;4159.899250878302;4161.83352665893;4079;4088.652464540503;4101.446304748851;4104.876853694379;4114.8971275718195;4055.2700513907484;4083.5508094109623;4105.712600117978;4112.650424713873;4115.97942010291;3568.5020485659884;3583.6595523425235;3595.856165753367;3598.5142005829402;3599.8120620195273;5315.123004704219;5322.866928326823;5348.197770334442;5350.759215835296;5352.822379076597;4808.749725071507;4831.4685384607665;4845.152098382769;4850.684705494132;4865.124277630025;5811.186433899215;5820.796272130455;5830.892130495193;5836.182934389189;5837.357890632027;4034.334334834778;4040.5757395473347;4045.59544045596;4057.2696914555368;4062.7765472898977;5941.168236446901;6109.938900611026;6118.908216376713;6160.260768707739;6203.31763506014;4058.228936502055;4067.145899361108;4067.1662309226535;4069.8575549855614;4072.470578824793;4111.773852438145;4113.958860411418;4129.215449064668;4131.400946862688;4146.854860079943;4657.6273898088075;4768.117898188846;4780.95219047812;4781.569658730661;4802.375691160127;5847.619904706181;5849.9177652134495;5852.268466441695;5891.558133139946;5904.704764761745;1421.7156568686305;1431.2414420357227;1434.9139051656934;1435.978460323096;1436.5762100180473;926.9073092690677;947.4646824544111;952.3476418653106;970.8834939807268;971.32007594684;4995.950850321473;5019.548240658358;5028.673136246205;5045.84862454127;5049.899002020013;5998.670073146019;6013.338532761392;6056.788012419544;6061.969690151521;6062.211912451353;4803.687760295569;4929.285253638202;4994.475580064113;5012.699238045729;5030.144875371196;3146.2449012237357;3189.6012998375204;3199.184208026985;3205.5672484214333;3207.951880721791;5322.787088516493;5532;5540.589843418126;5571.1086226203615;5583.330000399897;6120.357362476876;6165.660888651078;6193.597416167935;6207.6585787781205;6239.812805615838;5508.173773933781;5534.723263836872;5540.196671482612;5561.833145005657;5576.302962129734;5935.0503919372695;6015.338312785678;6033.577649564489;6042.486388657014;6043.697815109139;5950.196723442453;5954.851128721643;5961.344252132349;5961.880762384815;5976.7908123215475;5392.784288628568;5478.726063696719;5564.248826408383;5566.304211973504;5584.4136365681015;4429.180601588717;4430.316479737679;4462.888427789331;4466.196084704784;4474.172278128557;5920.851978700567;5992.112484567348;6057.303410107894;6057.606255593372;6111.541634377529;5830.970845145747;5854.268216472941;5858.853528661817;5875.6474611523445;5884.176215329771;5831.241938547962;5838.824835254949;5844.561657875592;5857.150713146655;5868.647881127146;5555.8888822222525;5731.8567035824435;5744.310682718101;5774.56690748204;5795.217645617788;5849.795257165979;5854.619449735924;5877.118432235199;5879.647221166743;5880.470757631833;5529.474699903502;5659.349174844946;5689.630174038674;5720.856978575569;5724.942750572608 01:43:46 INFO - PID 19866 | |5;yui.html;746.652806445003;757.9431542634302;766.2337662337666;769.9874664815767;789.2186735132219;12132.878671213286;12715.36423178842;13595;14110.506132285373;14243.074200176994;15469.226538673078;15849.524514264562;15971.121588312639;15972.440964566242;16017.679646407094;885.9645614175441;917.6925729880464;918.1186061381082;920.7053742802306;921.1479381572052;908.2915326045695;912.4297314178639;914.3279689428298;915.922146617535;918.701422037837;934.4206591913023;943.4197968249512;943.7923656795494;944.9858252126223;948.7580666929957;913.8949020862586;928.3037721708719;931.7204838548408;945.1257586732314;946.2051876423802;687.3744892148121;689.021589343134;689.0491122251311;689.8344397344651;690.3545185251805;13274.46902123914;13406.597802065953;13418.127821691558;13420.5302814402;13429.194248345131;15635.374585016585;16610.50168494947;16626.168691565494;16698.415555455624;16730.079845608485;12527.74944501114;12631.684207894785;12682.429290681941;12908.225506469547;12912.289824059673;3051.1761824307314;3060.739837113848;3065.7853950223493;3066.923326916845;3069.907902762898;83407;83910;84345.15654843496;84783;85471;11823.704407389712;11904.880951190551;11959.820602690967;12068.336241506802;12112.81830772539;22564.435889102904;23551.29346119619;23770;23805.880970595037;23823.04707811668;6127.5404344674325;6147.44672979434;6171.84570385735;6186.845328866814;6192.721327540181;3030.2424393901524;3084.3214492811544;3099.1942095055447;3128;3140.9214769630944;3807.2956503047026;3894.415837624322;3896.337622604164;3901.356276214393;3904.06302487401;770.9306162445407;780.1262585903823;789.2147313423065;847.3814115695577;851.3657325292572;612.7273363353354;613.5490414545305;614.2230078950132;627.4854619212202;641.7176442365344;9672.08115229052;9805.950970245245;10098.343607665478;10873.83689244662;11343.546258149581;585.4175095779726;592.4667798980865;594.7502049139285;600.6936462404118;607.2166904692984;4654.86035418938;4758.143534163814;4788.545088216614;4935.087008903292;4935.531124543163;74256.25743742601;75353;86509.5674521636;88252;88835;66334.66832665805;69521.65239173772;69739;70393.2960670397;71321.2867871325;58678.706606467545;58718.41281587215;59073.40926590679;60381.39618603846;62023;9653.46905920181;10121.797564048826;10347.223958203014;10801.24391292602;10902.50938707776;26818.59772103381;26985.86507067452;27028.189154325402;27712.722872771013;27975.440491189656;33011.33977320488;33496.33007339888;33899.3220135591;33916;34912.825435872655;13675;13793.448262069405;14064.226467544384;14109.365078571695;14116.435342586181;16269.837301627305;16357;16723.331066757193;16743.66512669764;16924;14572.85427145715;14653.413863445343;15270.083794971893;15271.236438177824;15407.38370465169;12532.248065116122;12590.433430495832;12640.178388404724;12797.168184068007;14777.704445910807;14348.641283967985;15053.924730376279;15172.772408414103;15558.766618500958;15682.843171568138;10227.488625568543;10516.211284153565;10643.201759867887;10968.06771424406;11038.779224415306;11439.771204576029;11744.882551174378;12196.207246528948;12209.084318675958;12297.32364719949 01:43:46 INFO - PID 19866 | __end_tp_report 01:43:46 INFO - PID 19866 | __start_cc_report 01:43:46 INFO - PID 19866 | _x_x_mozilla_cycle_collect,343 01:43:46 INFO - PID 19866 | __end_cc_report 01:43:46 INFO - PID 19866 | __startTimestamp1495874626874__endTimestamp 01:43:46 INFO - PID 19866 | 01:43:46 INFO - PID 19866 | ------- Summary: start ------- 01:43:46 INFO - PID 19866 | Number of tests: 6 01:43:46 INFO - PID 19866 | 01:43:46 INFO - PID 19866 | [#0] dojo.html Cycles:165 Average:5256.44 Median:5422.35 stddev:631.79 (11.7%) stddev-sans-first:601.45 01:43:46 INFO - PID 19866 | Values: 2714.8 2744.8 2763.1 2779.7 2780.7 5216.2 5283.7 5346.3 5356.7 5379.4 5262.2 5309.5 5321.9 5356.0 5408.5 4649.2 4693.5 4715.2 4725.2 4780.6 4748.4 4755.4 4768.9 4780.0 4788.2 4660.1 4677.1 4714.0 4720.6 4777.8 4739.3 4746.2 4747.3 4808.4 4813.2 4690.2 4716.9 4732.8 4750.3 4755.6 5196.8 5284.6 5343.9 5347.1 5379.9 5696.3 5698.5 5753.9 5761.6 5775.2 5768.7 5783.5 5789.9 5802.8 5839.5 5267.3 5422.3 5426.4 5426.7 5427.1 5847.9 5862.1 5915.7 5968.5 6007.6 5714.9 5716.2 5716.5 5716.9 5774.5 5668.0 5778.0 5801.4 5818.0 5824.2 5594.2 5667.4 5695.1 5748.3 5751.3 5735.2 5747.3 5772.8 5798.5 5808.5 4775.0 4796.4 4802.7 4805.7 4845.5 3980.2 4081.5 4123.7 4126.1 4126.6 4787.9 4819.7 4884.1 4896.9 4906.0 5797.3 5814.7 5817.3 5822.5 5823.1 4883.6 4890.1 4895.5 4899.6 4933.0 4971.7 4977.3 5001.6 5046.6 5050.6 5339.5 5344.2 5347.5 5351.7 5391.5 5566.9 5642.9 5654.3 5690.1 5792.8 5234.5 5242.9 5263.4 5339.0 5366.3 5525.5 5693.4 5704.2 5709.2 5710.2 5720.2 5751.5 5764.7 5863.3 5863.4 5653.2 5654.6 5661.1 5662.6 5691.0 5641.4 5643.5 5647.0 5648.0 5656.5 5394.1 5482.1 5482.6 5509.4 5541.3 5680.1 5693.9 5694.1 5696.1 5750.7 5453.6 5490.9 5492.8 5501.5 5516.6 01:43:46 INFO - PID 19866 | 01:43:46 INFO - PID 19866 | [#1] ext.html Cycles:180 Average:30907.03 Median:16924.71 stddev:42203.69 (249.4%) stddev-sans-first:42261.09 01:43:46 INFO - PID 19866 | Values: 690.2 726.1 744.2 1110.0 1122.2 32172.8 33367.8 33389.0 33401.5 33473.8 35068.5 35295.5 35392.3 35512.8 35619.8 6575.9 6750.9 6848.7 6987.0 7006.5 6660.7 6736.3 6738.8 6743.9 6756.9 6731.1 6779.4 6782.7 6798.0 6798.3 6730.9 6743.1 6745.2 6750.3 6778.3 6542.5 6560.9 6581.7 6604.1 6606.8 31911.0 32091.8 32316.7 32353.8 32392.4 3003.4 3030.1 3035.5 3041.9 3042.5 24973.9 25034.4 25037.9 25133.9 25170.2 2984.0 3036.0 3046.6 3051.9 3082.2 144010.3 145050.0 145624.3 146162.3 148813.0 38840.2 38874.6 38931.0 39022.0 39161.6 40387.0 40719.4 40869.8 40904.2 43622.0 12122.4 12177.5 12277.8 12279.6 12319.5 9513.4 9525.4 9527.1 9528.9 9574.2 12628.2 12640.5 12696.2 12747.2 12927.0 5323.5 5568.1 5569.2 5574.6 5623.4 873.2 909.0 916.2 923.9 958.2 20777.9 20846.1 21039.8 21229.9 21463.7 995.1 1000.1 1000.9 1013.6 1023.8 11000.7 11474.4 11480.8 11497.4 11635.1 177703.0 178103.0 179320.0 179734.0 180138.0 40883.0 41118.6 41169.6 41329.4 41452.2 1214.5 1254.2 1257.2 1257.8 1261.5 19484.4 19802.7 20151.3 20591.9 21029.9 29259.9 36478.8 37750.8 37846.8 37850.4 162577.0 163703.0 164034.0 164324.0 164700.0 30187.0 30416.8 30605.5 30648.5 30767.2 35420.0 35732.8 35805.5 36142.6 36284.0 27793.0 27994.2 28199.2 28448.1 29337.4 27303.0 27593.6 27768.6 28280.0 28899.0 31284.0 31294.5 31381.2 31445.7 31489.0 26388.5 27031.9 27441.5 27647.0 29014.9 21879.7 22701.8 22723.0 22784.9 22960.2 01:43:46 INFO - PID 19866 | 01:43:46 INFO - PID 19866 | [#2] jquery.html Cycles:180 Average:25458.85 Median:20687.47 stddev:64243.74 (310.5%) stddev-sans-first:64396.40 01:43:46 INFO - PID 19866 | Values: 398.1 411.7 414.6 425.2 435.4 17349.6 17388.2 17957.6 18062.2 18073.7 18125.5 18306.7 18427.1 19102.6 19266.7 5390.9 5397.2 5633.1 5639.7 5641.6 5321.7 5412.1 5438.4 5445.8 5456.3 5401.7 5403.7 5405.8 5414.9 5432.4 5306.5 5358.7 5425.5 5432.1 5468.9 4900.0 4915.3 4922.4 4931.7 4933.3 21348.3 21770.7 21868.9 21914.0 22010.9 1559.9 1583.9 1587.2 1598.0 1598.5 14496.0 14711.1 14931.4 15079.7 15331.2 1876.3 1911.8 1928.7 1937.5 2011.2 91946.5 92705.0 93785.5 95096.0 95199.5 10691.2 10924.6 11018.6 11151.0 11222.7 14672.0 15150.8 15195.9 15340.7 15368.5 7342.4 7490.0 7557.5 7649.3 7656.0 6957.1 6957.3 7121.4 7130.0 7136.3 6873.5 6911.0 6915.4 6965.3 7032.6 1932.8 1937.6 1954.7 1987.9 2099.6 840.2 876.5 878.8 887.5 907.6 17246.2 17299.2 17368.7 17602.4 18362.0 846.2 886.7 891.6 893.0 905.7 9329.3 9816.4 9880.1 9889.5 10068.7 378383.0 383126.0 383445.9 391083.0 391160.0 77406.2 77583.2 78207.0 78750.6 78900.6 1069.3 1073.9 1078.5 1086.8 1092.9 14550.6 14735.3 14858.7 15070.9 15501.5 38473.2 38759.4 39701.8 40976.8 41138.8 46613.5 51852.2 52389.0 53424.0 53489.0 7703.6 7760.4 7866.0 8047.6 8192.3 11977.2 12123.2 12336.1 12379.8 12386.0 9592.6 10301.0 10484.4 10602.3 10770.0 10362.8 10534.2 10623.8 10647.8 10685.8 9653.7 9725.6 10053.9 10463.5 10499.0 7659.2 7831.3 7859.3 8095.6 8161.2 9955.1 10019.4 10055.2 10351.7 10469.2 01:43:46 INFO - PID 19866 | 01:43:46 INFO - PID 19866 | [#3] mootools.html Cycles:180 Average:6332.27 Median:3693.82 stddev:4125.65 (111.7%) stddev-sans-first:4119.83 01:43:46 INFO - PID 19866 | Values: 1290.6 1334.9 1356.5 1358.0 1358.2 9983.3 10268.7 10452.5 10468.7 10777.6 10533.3 10690.1 10709.7 10710.5 10729.5 2089.5 2137.1 2151.5 2154.9 2160.3 2081.8 2107.3 2113.0 2117.8 2121.7 2049.7 2080.3 2087.0 2088.4 2095.1 2011.2 2030.6 2036.9 2038.2 2044.6 2000.7 2061.4 2066.0 2110.3 2118.5 10280.6 10311.9 10345.6 10352.6 10396.9 5554.1 5719.5 5762.9 5765.0 5770.4 3263.4 3415.2 3433.6 3479.4 3495.0 1125.9 1126.6 1134.3 1140.8 1152.1 14978.3 15114.9 15120.0 15208.9 15270.1 4762.7 4809.1 4920.3 4928.9 4932.0 10944.9 11027.2 11032.5 11040.2 11053.0 5520.6 5620.7 5624.0 5624.7 5626.5 5017.4 5192.6 5202.7 5214.3 5220.9 3788.0 3878.3 3908.3 3928.7 3961.6 1085.1 1114.8 1119.3 1120.1 1121.7 691.9 714.3 719.2 725.6 737.3 5417.0 5451.6 5474.2 5542.4 5636.9 504.6 527.7 528.8 531.0 532.2 3424.9 3685.5 3702.1 3782.1 3915.6 12791.3 13313.7 13330.7 13582.6 13804.5 13348.1 13548.5 13618.5 13626.5 13872.2 7190.4 7226.5 7437.7 7611.2 7661.3 5924.4 6238.0 6354.3 6475.8 6589.6 11533.7 12400.2 12441.3 12461.9 12532.3 11863.7 11865.1 11978.0 12079.6 12097.6 8268.0 8573.5 8595.1 8608.2 8610.3 9546.4 9561.0 9615.7 9617.9 9636.1 8199.3 8401.2 8472.7 8542.9 8641.1 7928.0 8033.8 8085.7 8175.9 8178.6 7134.6 7150.4 7200.6 7207.9 7210.0 5037.4 5176.9 5237.6 5245.4 5343.0 5202.4 5203.8 5235.7 5297.6 5353.7 01:43:46 INFO - PID 19866 | 01:43:46 INFO - PID 19866 | [#4] prototype.html Cycles:180 Average:4788.04 Median:5521.15 stddev:1429.42 (25.9%) stddev-sans-first:1393.92 01:43:46 INFO - PID 19866 | Values: 341.3 363.7 368.2 368.7 378.4 5553.3 5571.7 5620.2 5631.4 5657.2 5482.4 5519.9 5522.4 5530.5 5534.1 4029.5 4109.7 4261.9 4278.1 4282.3 4142.6 4151.1 4156.6 4159.9 4161.8 4079.0 4088.7 4101.4 4104.9 4114.9 4055.3 4083.6 4105.7 4112.7 4116.0 3568.5 3583.7 3595.9 3598.5 3599.8 5315.1 5322.9 5348.2 5350.8 5352.8 4808.7 4831.5 4845.2 4850.7 4865.1 5811.2 5820.8 5830.9 5836.2 5837.4 4034.3 4040.6 4045.6 4057.3 4062.8 5941.2 6109.9 6118.9 6160.3 6203.3 4058.2 4067.1 4067.2 4069.9 4072.5 4111.8 4114.0 4129.2 4131.4 4146.9 4657.6 4768.1 4781.0 4781.6 4802.4 5847.6 5849.9 5852.3 5891.6 5904.7 1421.7 1431.2 1434.9 1436.0 1436.6 926.9 947.5 952.3 970.9 971.3 4996.0 5019.5 5028.7 5045.8 5049.9 5998.7 6013.3 6056.8 6062.0 6062.2 4803.7 4929.3 4994.5 5012.7 5030.1 3146.2 3189.6 3199.2 3205.6 3208.0 5322.8 5532.0 5540.6 5571.1 5583.3 6120.4 6165.7 6193.6 6207.7 6239.8 5508.2 5534.7 5540.2 5561.8 5576.3 5935.1 6015.3 6033.6 6042.5 6043.7 5950.2 5954.9 5961.3 5961.9 5976.8 5392.8 5478.7 5564.2 5566.3 5584.4 4429.2 4430.3 4462.9 4466.2 4474.2 5920.9 5992.1 6057.3 6057.6 6111.5 5831.0 5854.3 5858.9 5875.6 5884.2 5831.2 5838.8 5844.6 5857.2 5868.6 5555.9 5731.9 5744.3 5774.6 5795.2 5849.8 5854.6 5877.1 5879.6 5880.5 5529.5 5659.3 5689.6 5720.9 5724.9 01:43:46 INFO - PID 19866 | 01:43:46 INFO - PID 19866 | [#5] yui.html Cycles:180 Average:16947.01 Median:3134.46 stddev:22020.06 (702.5%) stddev-sans-first:22048.22 01:43:46 INFO - PID 19866 | Values: 746.7 757.9 766.2 770.0 789.2 12132.9 12715.4 13595.0 14110.5 14243.1 15469.2 15849.5 15971.1 15972.4 16017.7 886.0 917.7 918.1 920.7 921.1 908.3 912.4 914.3 915.9 918.7 934.4 943.4 943.8 945.0 948.8 913.9 928.3 931.7 945.1 946.2 687.4 689.0 689.0 689.8 690.4 13274.5 13406.6 13418.1 13420.5 13429.2 15635.4 16610.5 16626.2 16698.4 16730.1 12527.7 12631.7 12682.4 12908.2 12912.3 3051.2 3060.7 3065.8 3066.9 3069.9 83407.0 83910.0 84345.2 84783.0 85471.0 11823.7 11904.9 11959.8 12068.3 12112.8 22564.4 23551.3 23770.0 23805.9 23823.0 6127.5 6147.4 6171.8 6186.8 6192.7 3030.2 3084.3 3099.2 3128.0 3140.9 3807.3 3894.4 3896.3 3901.4 3904.1 770.9 780.1 789.2 847.4 851.4 612.7 613.5 614.2 627.5 641.7 9672.1 9806.0 10098.3 10873.8 11343.5 585.4 592.5 594.8 600.7 607.2 4654.9 4758.1 4788.5 4935.1 4935.5 74256.3 75353.0 86509.6 88252.0 88835.0 66334.7 69521.7 69739.0 70393.3 71321.3 58678.7 58718.4 59073.4 60381.4 62023.0 9653.5 10121.8 10347.2 10801.2 10902.5 26818.6 26985.9 27028.2 27712.7 27975.4 33011.3 33496.3 33899.3 33916.0 34912.8 13675.0 13793.4 14064.2 14109.4 14116.4 16269.8 16357.0 16723.3 16743.7 16924.0 14572.9 14653.4 15270.1 15271.2 15407.4 12532.2 12590.4 12640.2 12797.2 14777.7 14348.6 15053.9 15172.8 15558.8 15682.8 10227.5 10516.2 10643.2 10968.1 11038.8 11439.8 11744.9 12196.2 12209.1 12297.3 01:43:46 INFO - PID 19866 | -------- Summary: end -------- 01:43:46 INFO - PID 19866 | 01:43:47 INFO - TEST-INFO | 19866: exit 0 01:43:47 INFO - TEST-OK | dromaeo_css | took 1145244ms 01:43:47 INFO - TEST-START | kraken 01:43:47 INFO - operating with platform_type : linux_ 01:43:47 INFO - Initialising browser for kraken test... 01:43:47 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37553/getInfo.html -profile /tmp/tmpmx_LGK/profile 01:43:47 INFO - TEST-INFO | started process 20274 (/builds/slave/test/build/application/firefox/firefox http://localhost:37553/getInfo.html) 01:44:21 INFO - TEST-INFO | 20274: killed by SIGTERM 01:44:22 INFO - Browser initialized. 01:44:22 INFO - Running cycle 1/1 for kraken test... 01:44:22 INFO - TEST-INFO | started process 20474 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmx_LGK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:44:33 INFO - PID 20474 | RSS: Main: 168615936 01:44:33 INFO - PID 20474 | 01:44:36 INFO - PID 20474 | Cycle 1(1): loaded http://localhost:37553/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37553/tests/kraken/driver.html?testName=audio-beat-detection) 01:44:37 INFO - PID 20474 | RSS: Main: 175222784 01:44:37 INFO - PID 20474 | 01:44:40 INFO - PID 20474 | Cycle 1(1): loaded http://localhost:37553/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37553/tests/kraken/driver.html?testName=audio-dft) 01:44:40 INFO - PID 20474 | RSS: Main: 173584384 01:44:40 INFO - PID 20474 | 01:44:43 INFO - PID 20474 | Cycle 1(1): loaded http://localhost:37553/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37553/tests/kraken/driver.html?testName=audio-fft) 01:44:44 INFO - PID 20474 | RSS: Main: 171732992 01:44:44 INFO - PID 20474 | 01:44:46 INFO - PID 20474 | Cycle 1(1): loaded http://localhost:37553/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37553/tests/kraken/driver.html?testName=audio-oscillator) 01:44:47 INFO - PID 20474 | RSS: Main: 172220416 01:44:47 INFO - PID 20474 | 01:44:49 INFO - PID 20474 | Cycle 1(1): loaded http://localhost:37553/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37553/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:44:49 INFO - PID 20474 | RSS: Main: 172085248 01:44:49 INFO - PID 20474 | 01:44:52 INFO - PID 20474 | Cycle 1(1): loaded http://localhost:37553/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37553/tests/kraken/driver.html?testName=imaging-darkroom) 01:44:53 INFO - PID 20474 | RSS: Main: 173223936 01:44:53 INFO - PID 20474 | 01:44:57 INFO - PID 20474 | Cycle 1(1): loaded http://localhost:37553/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37553/tests/kraken/driver.html?testName=imaging-desaturate) 01:44:57 INFO - PID 20474 | RSS: Main: 172580864 01:44:57 INFO - PID 20474 | 01:45:00 INFO - PID 20474 | Cycle 1(1): loaded http://localhost:37553/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37553/tests/kraken/driver.html?testName=json-parse-financial) 01:45:01 INFO - PID 20474 | RSS: Main: 172818432 01:45:01 INFO - PID 20474 | 01:45:02 INFO - PID 20474 | Cycle 1(1): loaded http://localhost:37553/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37553/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:45:03 INFO - PID 20474 | RSS: Main: 172920832 01:45:03 INFO - PID 20474 | 01:45:05 INFO - PID 20474 | Cycle 1(1): loaded http://localhost:37553/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37553/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:45:05 INFO - PID 20474 | RSS: Main: 173047808 01:45:05 INFO - PID 20474 | 01:45:08 INFO - PID 20474 | Cycle 1(1): loaded http://localhost:37553/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37553/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:45:08 INFO - PID 20474 | RSS: Main: 173043712 01:45:08 INFO - PID 20474 | 01:45:11 INFO - PID 20474 | Cycle 1(1): loaded http://localhost:37553/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37553/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:45:12 INFO - PID 20474 | RSS: Main: 173441024 01:45:12 INFO - PID 20474 | 01:45:15 INFO - PID 20474 | Cycle 1(1): loaded http://localhost:37553/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37553/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:45:15 INFO - PID 20474 | RSS: Main: 173735936 01:45:15 INFO - PID 20474 | 01:45:17 INFO - PID 20474 | Cycle 1(1): loaded http://localhost:37553/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37553/tests/kraken/driver.html?testName=ai-astar) 01:45:17 INFO - PID 20474 | RSS: Main: 174878720 01:45:17 INFO - PID 20474 | 01:45:17 INFO - PID 20474 | __start_tp_report 01:45:17 INFO - PID 20474 | _x_x_mozilla_page_load 01:45:17 INFO - PID 20474 | _x_x_mozilla_page_load_details 01:45:17 INFO - PID 20474 | |i|pagename|runs| 01:45:17 INFO - PID 20474 | |0;ai-astar;103;110;112;111;110;113;113;110;111;110 01:45:17 INFO - PID 20474 | |1;audio-beat-detection;152;123;123;161;123;127;124;122;145;123 01:45:17 INFO - PID 20474 | |2;audio-dft;164;165;164;165;166;166;168;174;164;165 01:45:17 INFO - PID 20474 | |3;audio-fft;76;74;74;115;76;78;85;75;94;75 01:45:17 INFO - PID 20474 | |4;audio-oscillator;84;84;100;84;84;84;95;82;85;104 01:45:17 INFO - PID 20474 | |5;imaging-gaussian-blur;113;114;115;117;114;114;115;115;115;114 01:45:17 INFO - PID 20474 | |6;imaging-darkroom;150;151;151;150;150;151;150;150;151;151 01:45:17 INFO - PID 20474 | |7;imaging-desaturate;95;95;94;96;95;95;95;95;94;94 01:45:17 INFO - PID 20474 | |8;json-parse-financial;56;57;57;55;58;57;57;57;57;58 01:45:17 INFO - PID 20474 | |9;json-stringify-tinderbox;57;57;57;57;57;57;57;56;57;57 01:45:17 INFO - PID 20474 | |10;stanford-crypto-aes;88;87;85;89;87;86;88;89;126;86 01:45:17 INFO - PID 20474 | |11;stanford-crypto-ccm;137;137;130;142;148;143;134;140;136;137 01:45:17 INFO - PID 20474 | |12;stanford-crypto-pbkdf2;193;198;196;190;191;201;193;187;191;196 01:45:17 INFO - PID 20474 | |13;stanford-crypto-sha256-iterative;72;73;75;71;75;72;71;73;71;70 01:45:17 INFO - PID 20474 | __end_tp_report 01:45:17 INFO - PID 20474 | __start_cc_report 01:45:17 INFO - PID 20474 | _x_x_mozilla_cycle_collect,917 01:45:17 INFO - PID 20474 | __end_cc_report 01:45:17 INFO - PID 20474 | __startTimestamp1495874717983__endTimestamp 01:45:17 INFO - PID 20474 | 01:45:17 INFO - PID 20474 | ------- Summary: start ------- 01:45:17 INFO - PID 20474 | Number of tests: 14 01:45:17 INFO - PID 20474 | 01:45:17 INFO - PID 20474 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:2.83 (2.5%) stddev-sans-first:1.27 01:45:17 INFO - PID 20474 | Values: 103.0 110.0 112.0 111.0 110.0 113.0 113.0 110.0 111.0 110.0 01:45:17 INFO - PID 20474 | 01:45:17 INFO - PID 20474 | [#1] audio-beat-detection Cycles:10 Average:132.30 Median:125.50 stddev:14.61 (11.6%) stddev-sans-first:13.65 01:45:17 INFO - PID 20474 | Values: 152.0 123.0 123.0 161.0 123.0 127.0 124.0 122.0 145.0 123.0 01:45:17 INFO - PID 20474 | 01:45:17 INFO - PID 20474 | [#2] audio-dft Cycles:10 Average:166.10 Median:165.50 stddev:3.03 (1.8%) stddev-sans-first:3.12 01:45:17 INFO - PID 20474 | Values: 164.0 165.0 164.0 165.0 166.0 166.0 168.0 174.0 164.0 165.0 01:45:17 INFO - PID 20474 | 01:45:17 INFO - PID 20474 | [#3] audio-fft Cycles:10 Average:82.20 Median:76.00 stddev:13.15 (17.3%) stddev-sans-first:13.75 01:45:17 INFO - PID 20474 | Values: 76.0 74.0 74.0 115.0 76.0 78.0 85.0 75.0 94.0 75.0 01:45:17 INFO - PID 20474 | 01:45:17 INFO - PID 20474 | [#4] audio-oscillator Cycles:10 Average:88.60 Median:84.00 stddev:7.96 (9.5%) stddev-sans-first:8.27 01:45:17 INFO - PID 20474 | Values: 84.0 84.0 100.0 84.0 84.0 84.0 95.0 82.0 85.0 104.0 01:45:17 INFO - PID 20474 | 01:45:17 INFO - PID 20474 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:115.00 stddev:1.07 (0.9%) stddev-sans-first:0.97 01:45:17 INFO - PID 20474 | Values: 113.0 114.0 115.0 117.0 114.0 114.0 115.0 115.0 115.0 114.0 01:45:17 INFO - PID 20474 | 01:45:17 INFO - PID 20474 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:151.00 stddev:0.53 (0.3%) stddev-sans-first:0.53 01:45:17 INFO - PID 20474 | Values: 150.0 151.0 151.0 150.0 150.0 151.0 150.0 150.0 151.0 151.0 01:45:17 INFO - PID 20474 | 01:45:17 INFO - PID 20474 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 01:45:17 INFO - PID 20474 | Values: 95.0 95.0 94.0 96.0 95.0 95.0 95.0 95.0 94.0 94.0 01:45:17 INFO - PID 20474 | 01:45:18 INFO - PID 20474 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:57.00 stddev:0.88 (1.5%) stddev-sans-first:0.87 01:45:18 INFO - PID 20474 | Values: 56.0 57.0 57.0 55.0 58.0 57.0 57.0 57.0 57.0 58.0 01:45:18 INFO - PID 20474 | 01:45:18 INFO - PID 20474 | [#9] json-stringify-tinderbox Cycles:10 Average:56.90 Median:57.00 stddev:0.32 (0.6%) stddev-sans-first:0.33 01:45:18 INFO - PID 20474 | Values: 57.0 57.0 57.0 57.0 57.0 57.0 57.0 56.0 57.0 57.0 01:45:18 INFO - PID 20474 | 01:45:18 INFO - PID 20474 | [#10] stanford-crypto-aes Cycles:10 Average:91.10 Median:87.50 stddev:12.33 (14.1%) stddev-sans-first:13.03 01:45:18 INFO - PID 20474 | Values: 88.0 87.0 85.0 89.0 87.0 86.0 88.0 89.0 126.0 86.0 01:45:18 INFO - PID 20474 | 01:45:18 INFO - PID 20474 | [#11] stanford-crypto-ccm Cycles:10 Average:138.40 Median:138.50 stddev:5.06 (3.7%) stddev-sans-first:5.34 01:45:18 INFO - PID 20474 | Values: 137.0 137.0 130.0 142.0 148.0 143.0 134.0 140.0 136.0 137.0 01:45:18 INFO - PID 20474 | 01:45:18 INFO - PID 20474 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.60 Median:194.50 stddev:4.17 (2.1%) stddev-sans-first:4.42 01:45:18 INFO - PID 20474 | Values: 193.0 198.0 196.0 190.0 191.0 201.0 193.0 187.0 191.0 196.0 01:45:18 INFO - PID 20474 | 01:45:18 INFO - PID 20474 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:72.50 stddev:1.70 (2.3%) stddev-sans-first:1.80 01:45:18 INFO - PID 20474 | Values: 72.0 73.0 75.0 71.0 75.0 72.0 71.0 73.0 71.0 70.0 01:45:18 INFO - PID 20474 | -------- Summary: end -------- 01:45:18 INFO - PID 20474 | 01:45:19 INFO - TEST-INFO | 20474: exit 0 01:45:19 INFO - TEST-OK | kraken | took 91388ms 01:45:19 INFO - SUITE-END | took 1236s 01:45:19 INFO - Completed test suite (00:20:36) 01:45:19 INFO - javascript benchmark 01:45:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6774.695980010461, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2714.755671989521, 2744.84903330317, 2763.0605594098015, 2779.708130646281, 2780.652418447694, 5216.217567364897, 5283.682979021261, 5346.2515247865285, 5356.741165826033, 5379.435159308275, 5262.210668399742, 5309.495597918191, 5321.920171197426, 5355.973220133894, 5408.4591540845895, 4649.186392381337, 4693.50718174591, 4715.198416269225, 4725.17309470843, 4780.641451891105, 4748.406449193851, 4755.381800365965, 4768.90462190756, 4780.0, 4788.233882578788, 4660.091282199973, 4677.134730074947, 4713.952860471386, 4720.622350211975, 4777.761111944389, 4739.336492890998, 4746.169420351424, 4747.311639812242, 4808.350872632185, 4813.229883218668, 4690.226112691402, 4716.9292460613115, 4732.810687572493, 4750.287456881495, 4755.571998520115, 5196.76614552346, 5284.550813180885, 5343.893122137574, 5347.0909945309395, 5379.892402151935, 5696.3449203341315, 5698.544116470673, 5753.8561535961935, 5761.567882408836, 5775.16260142277, 5768.74040668171, 5783.479486846204, 5789.884202315972, 5802.825915222508, 5839.474447299721, 5267.26258323835, 5422.349318081855, 5426.403095659474, 5426.70153141581, 5427.0773968425465, 5847.912281315784, 5862.062070068769, 5915.704214789243, 5968.46283834457, 6007.579469437185, 5714.914276285859, 5716.228309178291, 5716.5140963017775, 5716.885662286731, 5774.48029677331, 5667.971660141673, 5778.017736984722, 5801.448862358069, 5817.970910145422, 5824.213731146326, 5594.1888426177975, 5667.376588575254, 5695.060315047971, 5748.252727145445, 5751.252337196138, 5735.1970724098655, 5747.3103227612955, 5772.7690892363835, 5798.478136967693, 5808.5353171747, 4775.0, 4796.35249241348, 4802.663813533089, 4805.735684537384, 4845.491223421561, 3980.2238563480423, 4081.5306239782212, 4123.670106391482, 4126.112885729583, 4126.607972242692, 4787.928181077286, 4819.7108173509005, 4884.07202631506, 4896.902061958741, 4906.0, 5797.275340582427, 5814.680192589363, 5817.331006934172, 5822.505087067562, 5823.068309070529, 4883.560479556857, 4890.144224760653, 4895.461499235082, 4899.608031357483, 4933.0380575788095, 4971.676841005323, 4977.278294647328, 5001.649884508122, 5046.62150338726, 5050.570701490341, 5339.46605339463, 5344.171653393731, 5347.465253474621, 5351.652142610874, 5391.514763671288, 5566.944330556805, 5642.85892852682, 5654.293213348332, 5690.146478028163, 5792.797252096157, 5234.476552344735, 5242.921356179584, 5263.394709608444, 5338.97330513345, 5366.275552800322, 5525.530329922001, 5693.4021927696995, 5704.2014118024335, 5709.22925405065, 5710.172025056427, 5720.170575266647, 5751.511121554715, 5764.740586673526, 5863.2670916135485, 5863.413658634103, 5653.2085508028085, 5654.604177707521, 5661.122526008476, 5662.631928924607, 5691.0, 5641.407652196624, 5643.4920857121415, 5647.040003199384, 5648.039833228278, 5656.490915817596, 5394.109971854757, 5482.122860342326, 5482.616216864941, 5509.449055094458, 5541.2796336476, 5680.091185410314, 5693.8861222774485, 5694.117411801178, 5696.088625819849, 5750.741216645345, 5453.618246722692, 5490.945090549043, 5492.780288788564, 5501.477359650827, 5516.558675306046], "value": 5209.586857132656, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.2200513419834, 726.0670038999885, 744.2297222374843, 1110.0342701849388, 1122.1976286954825, 32172.83913580432, 33367.83316083419, 33389.0, 33401.49897751536, 33473.828416005446, 35068.473972890366, 35295.4705679415, 35392.2921541569, 35512.822435887785, 35619.82190089052, 6575.868482630344, 6750.864982700343, 6848.6918088686125, 6987.021816945632, 7006.509544331899, 6660.733570657168, 6736.326367363249, 6738.8315292117595, 6743.898841517381, 6756.864862702743, 6731.057651928734, 6779.423748981342, 6782.660866956657, 6798.0, 6798.286179951108, 6730.932690673079, 6743.089682892795, 6745.224299205581, 6750.291219421939, 6778.254392016875, 6542.4766018718865, 6560.868782624369, 6581.703823327962, 6604.108445359863, 6606.768763093269, 31911.0, 32091.839540802146, 32316.676833231835, 32353.838230808695, 32392.35215295681, 3003.3993201359817, 3030.10611869499, 3035.544668299751, 3041.863116159778, 3042.497987832005, 24973.875130624412, 25034.37414064663, 25037.874810626014, 25133.87433062823, 25170.24489265325, 2983.961579381733, 3036.0436462514235, 3046.558249053875, 3051.908442746721, 3082.1832214463184, 144010.27994859958, 145050.0, 145624.27187864098, 146162.26918865443, 148813.0, 38840.22319553593, 38874.61125388766, 38931.0, 39022.0, 39161.60838391637, 40387.0, 40719.38920916188, 40869.75216363129, 40904.18191636151, 43622.0, 12122.39388030595, 12177.452014659362, 12277.754444911052, 12279.631611051684, 12319.507219711291, 9513.429194248367, 9525.428474291564, 9527.09492598202, 9528.904710952802, 9574.234061275081, 12628.242305461701, 12640.494380224687, 12696.238225706487, 12747.171433856769, 12926.962163891478, 5323.467653234723, 5568.1091025435735, 5569.192467092249, 5574.58190635704, 5623.381428042912, 873.2315562305258, 908.981820363589, 916.2349438219028, 923.8544205185656, 958.2190514730472, 20777.896110519654, 20846.06192721301, 21039.78960210409, 21229.938503074784, 21463.712177269415, 995.124290624246, 1000.1049061090283, 1000.8748906386702, 1013.5945621751358, 1023.7952409518126, 11000.724981875357, 11474.426278686033, 11480.827787583194, 11497.425128743696, 11635.127365447624, 177703.0, 178103.0, 179320.0, 179734.0, 180138.0, 40883.0, 41118.588814112074, 41169.58830411718, 41329.38005929913, 41452.1709565813, 1214.4534959268365, 1254.2411840836162, 1257.1639859493334, 1257.7798885195054, 1261.4890969157507, 19484.415467535997, 19802.70295945533, 20151.294704685264, 20591.8970405153, 21029.89485052565, 29259.85370073136, 36478.8176059118, 37750.81124594469, 37846.81076594599, 37850.43224351582, 162577.0, 163703.0, 164034.0, 164324.0, 164700.0, 30187.0, 30416.847915760278, 30605.540916886708, 30648.540271895494, 30767.2308192297, 35420.0, 35732.82133589315, 35805.46291805677, 36142.63857361393, 36284.0, 27793.0, 27994.16017519478, 28199.15402537927, 28448.146555603365, 29337.413251735274, 27303.0, 27593.58609620817, 27768.583471247544, 28280.0, 28899.0, 31284.0, 31294.53058204174, 31381.215469613442, 31445.685543144275, 31489.0, 26388.472230554897, 27031.891332497016, 27441.451170976867, 27647.0, 29014.854925725238, 21879.671804922622, 22701.772982269966, 22723.0, 22784.88607557018, 22960.19639312616], "value": 14609.379057637267, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.13604478282144, 411.72825934882985, 414.5936981757876, 425.24731225730454, 435.3687153627241, 17349.566260843487, 17388.21753021114, 17957.551061223443, 18062.18720157593, 18073.7288940666, 18125.546861328472, 18306.725399119023, 18427.078646067675, 19102.61794764104, 19266.71099933502, 5390.8921821563545, 5397.190421436777, 5633.126865335879, 5639.661620302774, 5641.605087643867, 5321.733913304339, 5412.07994640912, 5438.401775804658, 5445.782168713266, 5456.345238571377, 5401.70290634015, 5403.729813509329, 5405.783768649269, 5414.8917021659545, 5432.429594892519, 5306.469353064701, 5358.678479291236, 5425.538829199523, 5432.13085906257, 5468.945310546923, 4899.975500122512, 4915.3364295819965, 4922.384701912261, 4931.7040977541465, 4933.333999910002, 21348.252811151535, 21770.673439898415, 21868.89065554678, 21914.013869375918, 22010.88994555033, 1559.91420471874, 1583.8732901367978, 1587.1826009605063, 1597.952061438147, 1598.4964736108088, 14496.0, 14711.117332960057, 14931.402743890232, 15079.698406031928, 15331.156786376745, 1876.2963888541797, 1911.8279354857991, 1928.7492625958675, 1937.457511896657, 2011.225678113922, 91946.54026729823, 92705.0, 93785.53107234488, 95096.0, 95199.52400237955, 10691.198160138021, 10924.563017479211, 11018.614348497924, 11151.0, 11222.719432014102, 14672.0, 15150.848491515164, 15195.92402038005, 15340.693186136215, 15368.462103826312, 7342.375898048619, 7489.962550187214, 7557.5465472071855, 7649.349805266615, 7655.961720191475, 6957.076907965779, 6957.304269573002, 7121.394681452031, 7129.964350178216, 7136.286371362822, 6873.450123990169, 6910.965445172843, 6915.412189963909, 6965.33829286217, 7032.6132062736015, 1932.8357089647538, 1937.5931054478717, 1954.6579348613936, 1987.8807271563753, 2099.5800839832095, 840.1556435782122, 876.5047748022474, 878.7978764884112, 887.5029983209423, 907.6142639378238, 17246.223919923632, 17299.221535030953, 17368.739468907977, 17602.38391656286, 18362.0, 846.1876598465542, 886.6763631274667, 891.6121487153109, 892.9866052009226, 905.6694306578052, 9329.30030247734, 9816.361936474106, 9880.110790028932, 9889.456079915673, 10068.697939061693, 378383.0, 383126.0, 383445.9104749266, 391083.0, 391160.0, 77406.22593774102, 77583.22416775873, 78207.0, 78750.6062469684, 78900.60549697214, 1069.2622090757352, 1073.9087177589836, 1078.5092782783815, 1086.8369744538224, 1092.8524649172418, 14550.636234094232, 14735.26323683833, 14858.702825943637, 15070.924645377141, 15501.534953951399, 38473.230535389695, 38759.41860872033, 39701.801490993515, 40976.79511602423, 41138.79430602828, 46613.533864660916, 51852.22221666603, 52389.0, 53424.0, 53489.0, 7703.614819258903, 7760.379169666526, 7865.960670196612, 8047.557384343917, 8192.344612430872, 11977.221480603734, 12123.211991220542, 12336.136470447342, 12379.75240495203, 12386.0, 9592.568334425107, 10301.0, 10484.370937743759, 10602.310849794738, 10770.0, 10362.844557331797, 10534.209934254808, 10623.840642390525, 10647.840282395926, 10685.786284274427, 9653.662121825702, 9725.562349694139, 10053.949730251303, 10463.476826158814, 10499.0, 7659.157492675913, 7831.2560306770765, 7859.253370929752, 8095.595220239083, 8161.224683655043, 9955.104040636377, 10019.398836069859, 10055.245856560641, 10351.741206469898, 10469.162467002774], "value": 8739.963130293547, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1290.5805613175717, 1334.9466021359146, 1356.545557238325, 1357.9999999999993, 1358.2122369025963, 9983.30116891817, 10268.691939241817, 10452.529636166371, 10468.68593942181, 10777.56889724412, 10533.26267161299, 10690.091342235919, 10709.732256693587, 10710.518026688798, 10729.463526823667, 2089.508965393135, 2137.1451419432274, 2151.4943988162768, 2154.892255387232, 2160.3087012156116, 2081.84386171037, 2107.2729908181727, 2113.0491278924546, 2117.83057355412, 2121.671140973144, 2049.7130401743766, 2080.2927004818357, 2086.9791302087015, 2088.446561661161, 2095.1095784291615, 2011.1653663729535, 2030.5634288627941, 2036.887971161593, 2038.2458490358663, 2044.5604195097976, 2000.7399038125095, 2061.360978096795, 2065.9690104648294, 2110.2719561751173, 2118.50215199428, 10280.588776448933, 10311.896881031169, 10345.637902673445, 10352.58589656413, 10396.948015259875, 5554.1391084381985, 5719.485246327808, 5762.9135562966585, 5764.971175144139, 5770.365259821417, 3263.4452143135723, 3415.248645298055, 3433.639467855889, 3479.373712731707, 3495.038864312309, 1125.9211855170142, 1126.6394753678826, 1134.3364131982717, 1140.7604403075281, 1152.066825871047, 14978.325975331136, 15114.924425377912, 15120.017198882037, 15208.935374523788, 15270.083794972226, 4762.738049407247, 4809.110314591811, 4920.31115643803, 4928.926066109011, 4931.950680493221, 10944.945275273572, 11027.17296202788, 11032.50353734084, 11040.227184097197, 11053.0, 5520.613557051048, 5620.718964051781, 5623.971880140573, 5624.6625202487985, 5626.521745651666, 5017.394433781155, 5192.636515443883, 5202.739863006835, 5214.348206474191, 5220.869478263074, 3788.0, 3878.3406820840523, 3908.2769687607883, 3928.724989250782, 3961.623645753649, 1085.1102096280974, 1114.8049091409134, 1119.3172164979355, 1120.0983208517223, 1121.6635009497281, 691.8927566227243, 714.3463730686468, 719.1801346465035, 725.5610355734705, 737.2590546500733, 5416.9729151353995, 5451.64564303319, 5474.151506516497, 5542.39033706292, 5636.887262254732, 504.56607317706744, 527.6992114494778, 528.7514868012029, 531.0149672357721, 532.2362409941746, 3424.931501369959, 3685.5146660840524, 3702.129999450127, 3782.149016471272, 3915.647591716759, 12791.296478693761, 13313.733725325439, 13330.73338533224, 13582.59252222435, 13804.516841910485, 13348.065635405428, 13548.525801596898, 13618.523351682643, 13626.523071692443, 13872.167669939634, 7190.424766018706, 7226.458015648847, 7437.665305061285, 7611.238876112345, 7661.310482056641, 5924.437178468039, 6237.96881015592, 6354.26925903527, 6475.7733479328, 6589.637569933508, 11533.711657208636, 12400.19398739079, 12441.315727635067, 12461.87538124607, 12532.310722909962, 11863.703407414883, 11865.050795936477, 11978.04175665962, 12079.57721479744, 12097.637070887888, 8267.958660206661, 8573.485590864568, 8595.140485951355, 8608.182222688834, 8610.311175105851, 9546.42721436716, 9561.0, 9615.74995250613, 9617.855732164164, 9636.132748052709, 8199.344052475668, 8401.243888050105, 8472.661093556435, 8542.871856922275, 8641.135886411308, 7927.960360198162, 8033.8393232136195, 8085.676572937252, 8175.877361839458, 8178.631961561625, 7134.643267836691, 7150.356467917913, 7200.603966781878, 7207.891881621885, 7209.963950180216, 5037.445880953019, 5176.859438310895, 5237.554807841376, 5245.449227831023, 5343.0, 5202.375714914235, 5203.765830537711, 5235.712035838065, 5297.629165958346, 5353.732313384393], "value": 4690.303938664366, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.3343979240482, 363.7462894409508, 368.2469350178884, 368.7289841966156, 378.35112781579596, 5553.278073850399, 5571.749271282792, 5620.241267428896, 5631.352394474637, 5657.179708942201, 5482.369527504338, 5519.9448005519935, 5522.3649280332775, 5530.5299049580835, 5534.059209934311, 4029.516458025041, 4109.712320137592, 4261.914761704772, 4278.080212754257, 4282.31482962726, 4142.627163555279, 4151.12826306476, 4156.5635608261155, 4159.899250878302, 4161.83352665893, 4079.0, 4088.652464540503, 4101.446304748851, 4104.876853694379, 4114.8971275718195, 4055.2700513907484, 4083.5508094109623, 4105.712600117978, 4112.650424713873, 4115.97942010291, 3568.5020485659884, 3583.6595523425235, 3595.856165753367, 3598.5142005829402, 3599.8120620195273, 5315.123004704219, 5322.866928326823, 5348.197770334442, 5350.759215835296, 5352.822379076597, 4808.749725071507, 4831.4685384607665, 4845.152098382769, 4850.684705494132, 4865.124277630025, 5811.186433899215, 5820.796272130455, 5830.892130495193, 5836.182934389189, 5837.357890632027, 4034.334334834778, 4040.5757395473347, 4045.59544045596, 4057.2696914555368, 4062.7765472898977, 5941.168236446901, 6109.938900611026, 6118.908216376713, 6160.260768707739, 6203.31763506014, 4058.228936502055, 4067.145899361108, 4067.1662309226535, 4069.8575549855614, 4072.470578824793, 4111.773852438145, 4113.958860411418, 4129.215449064668, 4131.400946862688, 4146.854860079943, 4657.6273898088075, 4768.117898188846, 4780.95219047812, 4781.569658730661, 4802.375691160127, 5847.619904706181, 5849.9177652134495, 5852.268466441695, 5891.558133139946, 5904.704764761745, 1421.7156568686305, 1431.2414420357227, 1434.9139051656934, 1435.978460323096, 1436.5762100180473, 926.9073092690677, 947.4646824544111, 952.3476418653106, 970.8834939807268, 971.32007594684, 4995.950850321473, 5019.548240658358, 5028.673136246205, 5045.84862454127, 5049.899002020013, 5998.670073146019, 6013.338532761392, 6056.788012419544, 6061.969690151521, 6062.211912451353, 4803.687760295569, 4929.285253638202, 4994.475580064113, 5012.699238045729, 5030.144875371196, 3146.2449012237357, 3189.6012998375204, 3199.184208026985, 3205.5672484214333, 3207.951880721791, 5322.787088516493, 5532.0, 5540.589843418126, 5571.1086226203615, 5583.330000399897, 6120.357362476876, 6165.660888651078, 6193.597416167935, 6207.6585787781205, 6239.812805615838, 5508.173773933781, 5534.723263836872, 5540.196671482612, 5561.833145005657, 5576.302962129734, 5935.0503919372695, 6015.338312785678, 6033.577649564489, 6042.486388657014, 6043.697815109139, 5950.196723442453, 5954.851128721643, 5961.344252132349, 5961.880762384815, 5976.7908123215475, 5392.784288628568, 5478.726063696719, 5564.248826408383, 5566.304211973504, 5584.4136365681015, 4429.180601588717, 4430.316479737679, 4462.888427789331, 4466.196084704784, 4474.172278128557, 5920.851978700567, 5992.112484567348, 6057.303410107894, 6057.606255593372, 6111.541634377529, 5830.970845145747, 5854.268216472941, 5858.853528661817, 5875.6474611523445, 5884.176215329771, 5831.241938547962, 5838.824835254949, 5844.561657875592, 5857.150713146655, 5868.647881127146, 5555.8888822222525, 5731.8567035824435, 5744.310682718101, 5774.56690748204, 5795.217645617788, 5849.795257165979, 5854.619449735924, 5877.118432235199, 5879.647221166743, 5880.470757631833, 5529.474699903502, 5659.349174844946, 5689.630174038674, 5720.856978575569, 5724.942750572608], "value": 4339.322866506154, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.652806445003, 757.9431542634302, 766.2337662337666, 769.9874664815767, 789.2186735132219, 12132.878671213286, 12715.36423178842, 13595.0, 14110.506132285373, 14243.074200176994, 15469.226538673078, 15849.524514264562, 15971.121588312639, 15972.440964566242, 16017.679646407094, 885.9645614175441, 917.6925729880464, 918.1186061381082, 920.7053742802306, 921.1479381572052, 908.2915326045695, 912.4297314178639, 914.3279689428298, 915.922146617535, 918.701422037837, 934.4206591913023, 943.4197968249512, 943.7923656795494, 944.9858252126223, 948.7580666929957, 913.8949020862586, 928.3037721708719, 931.7204838548408, 945.1257586732314, 946.2051876423802, 687.3744892148121, 689.021589343134, 689.0491122251311, 689.8344397344651, 690.3545185251805, 13274.46902123914, 13406.597802065953, 13418.127821691558, 13420.5302814402, 13429.194248345131, 15635.374585016585, 16610.50168494947, 16626.168691565494, 16698.415555455624, 16730.079845608485, 12527.74944501114, 12631.684207894785, 12682.429290681941, 12908.225506469547, 12912.289824059673, 3051.1761824307314, 3060.739837113848, 3065.7853950223493, 3066.923326916845, 3069.907902762898, 83407.0, 83910.0, 84345.15654843496, 84783.0, 85471.0, 11823.704407389712, 11904.880951190551, 11959.820602690967, 12068.336241506802, 12112.81830772539, 22564.435889102904, 23551.29346119619, 23770.0, 23805.880970595037, 23823.04707811668, 6127.5404344674325, 6147.44672979434, 6171.84570385735, 6186.845328866814, 6192.721327540181, 3030.2424393901524, 3084.3214492811544, 3099.1942095055447, 3128.0, 3140.9214769630944, 3807.2956503047026, 3894.415837624322, 3896.337622604164, 3901.356276214393, 3904.06302487401, 770.9306162445407, 780.1262585903823, 789.2147313423065, 847.3814115695577, 851.3657325292572, 612.7273363353354, 613.5490414545305, 614.2230078950132, 627.4854619212202, 641.7176442365344, 9672.08115229052, 9805.950970245245, 10098.343607665478, 10873.83689244662, 11343.546258149581, 585.4175095779726, 592.4667798980865, 594.7502049139285, 600.6936462404118, 607.2166904692984, 4654.86035418938, 4758.143534163814, 4788.545088216614, 4935.087008903292, 4935.531124543163, 74256.25743742601, 75353.0, 86509.5674521636, 88252.0, 88835.0, 66334.66832665805, 69521.65239173772, 69739.0, 70393.2960670397, 71321.2867871325, 58678.706606467545, 58718.41281587215, 59073.40926590679, 60381.39618603846, 62023.0, 9653.46905920181, 10121.797564048826, 10347.223958203014, 10801.24391292602, 10902.50938707776, 26818.59772103381, 26985.86507067452, 27028.189154325402, 27712.722872771013, 27975.440491189656, 33011.33977320488, 33496.33007339888, 33899.3220135591, 33916.0, 34912.825435872655, 13675.0, 13793.448262069405, 14064.226467544384, 14109.365078571695, 14116.435342586181, 16269.837301627305, 16357.0, 16723.331066757193, 16743.66512669764, 16924.0, 14572.85427145715, 14653.413863445343, 15270.083794971893, 15271.236438177824, 15407.38370465169, 12532.248065116122, 12590.433430495832, 12640.178388404724, 12797.168184068007, 14777.704445910807, 14348.641283967985, 15053.924730376279, 15172.772408414103, 15558.766618500958, 15682.843171568138, 10227.488625568543, 10516.211284153565, 10643.201759867887, 10968.06771424406, 11038.779224415306, 11439.771204576029, 11744.882551174378, 12196.207246528948, 12209.084318675958, 12297.32364719949], "value": 7140.681017802222, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1548.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 112.0, 111.0, 110.0, 113.0, 113.0, 110.0, 111.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 123.0, 123.0, 161.0, 123.0, 127.0, 124.0, 122.0, 145.0, 123.0], "value": 132.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 164.0, 165.0, 166.0, 166.0, 168.0, 174.0, 164.0, 165.0], "value": 166.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 74.0, 115.0, 76.0, 78.0, 85.0, 75.0, 94.0, 75.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 100.0, 84.0, 84.0, 84.0, 95.0, 82.0, 85.0, 104.0], "value": 88.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 115.0, 117.0, 114.0, 114.0, 115.0, 115.0, 115.0, 114.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 151.0, 150.0, 150.0, 151.0, 150.0, 150.0, 151.0, 151.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 96.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 57.0, 55.0, 58.0, 57.0, 57.0, 57.0, 57.0, 58.0], "value": 56.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 57.0, 57.0, 57.0, 57.0, 56.0, 57.0, 57.0], "value": 56.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 85.0, 89.0, 87.0, 86.0, 88.0, 89.0, 126.0, 86.0], "value": 91.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 137.0, 130.0, 142.0, 148.0, 143.0, 134.0, 140.0, 136.0, 137.0], "value": 138.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 198.0, 196.0, 190.0, 191.0, 201.0, 193.0, 187.0, 191.0, 196.0], "value": 193.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 75.0, 71.0, 75.0, 72.0, 71.0, 73.0, 71.0, 70.0], "value": 72.3, "unit": "score"}]}]} 01:45:19 INFO - Return code: 0 01:45:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:45:19 INFO - # TBPL SUCCESS # 01:45:19 INFO - Running post-action listener: _resource_record_post_action 01:45:19 INFO - [mozharness: 2017-05-27 08:45:19.295111Z] Finished run-tests step (success) 01:45:19 INFO - Running post-run listener: _resource_record_post_run 01:45:19 INFO - Total resource usage - Wall time: 1252s; CPU: 13.0%; Read bytes: 0; Write bytes: 402993152; Read time: 0; Write time: 218028 01:45:19 INFO - TinderboxPrint: CPU usage
12.6% 01:45:19 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 01:45:19 INFO - TinderboxPrint: I/O write bytes / time
402,993,152 / 218,028 01:45:19 INFO - TinderboxPrint: CPU idle
8,731.1 (87.4%) 01:45:19 INFO - TinderboxPrint: CPU user
1,214.2 (12.1%) 01:45:19 INFO - TinderboxPrint: Swap in / out
0 / 0 01:45:19 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 97144832; Read time: 0; Write time: 75716 01:45:19 INFO - run-tests - Wall time: 1237s; CPU: 13.0%; Read bytes: 0; Write bytes: 305422336; Read time: 0; Write time: 142288 01:45:19 INFO - Running post-run listener: _upload_blobber_files 01:45:19 INFO - Blob upload gear active. 01:45:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:45:19 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 01:45:19 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'] 01:45:19 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 01:45:20 INFO - (blobuploader) - INFO - Open directory for files ... 01:45:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:45:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:45:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:45:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:45:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:45:21 INFO - (blobuploader) - INFO - Done attempting. 01:45:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:45:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:45:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:45:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:45:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:45:24 INFO - (blobuploader) - INFO - Done attempting. 01:45:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:45:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:45:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:45:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:45:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:45:25 INFO - (blobuploader) - INFO - Done attempting. 01:45:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 01:45:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:45:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:45:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 01:45:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:45:26 INFO - (blobuploader) - INFO - Done attempting. 01:45:26 INFO - (blobuploader) - INFO - Iteration through files over. 01:45:26 INFO - Return code: 0 01:45:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:45:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:45:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/788a1be7c8a3ac6c18cdc857df3df47002acb94fdc432919d903fd8f962868344628427189b44391f5743b8f83f80ace2d071cdfbc4751f56b3ed665831b8f03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b8e50fce36961f90b058361e12c381f7161df1ddf432faf6a71292b9a630d0c96ffc52e38088e65908eff97524a3420acbf090f64d841c8ab4cc4fa2b2f02459", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/28bbcb405e46ca48fe6356c7188c70ee9e71c24a2a1079f456b280681089f0f67513592c11fee68eee9a9a6db2e978695497155ca6ef8f7d7e024705eadd7655", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e7903d5e592b01e858459adbf2499eb51bde90a52bd27a3f41d14d137062b731138c4884b928860bf0d07391203af348e2cb04db09ce232bdbb02f6400a5032"} 01:45:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:45:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:45:26 INFO - Contents: 01:45:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/788a1be7c8a3ac6c18cdc857df3df47002acb94fdc432919d903fd8f962868344628427189b44391f5743b8f83f80ace2d071cdfbc4751f56b3ed665831b8f03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b8e50fce36961f90b058361e12c381f7161df1ddf432faf6a71292b9a630d0c96ffc52e38088e65908eff97524a3420acbf090f64d841c8ab4cc4fa2b2f02459", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/28bbcb405e46ca48fe6356c7188c70ee9e71c24a2a1079f456b280681089f0f67513592c11fee68eee9a9a6db2e978695497155ca6ef8f7d7e024705eadd7655", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e7903d5e592b01e858459adbf2499eb51bde90a52bd27a3f41d14d137062b731138c4884b928860bf0d07391203af348e2cb04db09ce232bdbb02f6400a5032"} 01:45:26 INFO - Running post-run listener: copy_logs_to_upload_dir 01:45:26 INFO - Copying logs to upload dir... 01:45:26 INFO - mkdir: /builds/slave/test/build/upload/logs 01:45:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1309.915427 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 49 secs) (at 2017-05-27 01:45:25.235165) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-27 01:45:25.239014) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1495858813.155868-861733865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/788a1be7c8a3ac6c18cdc857df3df47002acb94fdc432919d903fd8f962868344628427189b44391f5743b8f83f80ace2d071cdfbc4751f56b3ed665831b8f03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b8e50fce36961f90b058361e12c381f7161df1ddf432faf6a71292b9a630d0c96ffc52e38088e65908eff97524a3420acbf090f64d841c8ab4cc4fa2b2f02459", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/28bbcb405e46ca48fe6356c7188c70ee9e71c24a2a1079f456b280681089f0f67513592c11fee68eee9a9a6db2e978695497155ca6ef8f7d7e024705eadd7655", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e7903d5e592b01e858459adbf2499eb51bde90a52bd27a3f41d14d137062b731138c4884b928860bf0d07391203af348e2cb04db09ce232bdbb02f6400a5032"} build_url:https://queue.taskcluster.net/v1/task/EE25Ah43Tq2wB9-VWI1O1A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011099 build_url: 'https://queue.taskcluster.net/v1/task/EE25Ah43Tq2wB9-VWI1O1A/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/788a1be7c8a3ac6c18cdc857df3df47002acb94fdc432919d903fd8f962868344628427189b44391f5743b8f83f80ace2d071cdfbc4751f56b3ed665831b8f03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b8e50fce36961f90b058361e12c381f7161df1ddf432faf6a71292b9a630d0c96ffc52e38088e65908eff97524a3420acbf090f64d841c8ab4cc4fa2b2f02459", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/28bbcb405e46ca48fe6356c7188c70ee9e71c24a2a1079f456b280681089f0f67513592c11fee68eee9a9a6db2e978695497155ca6ef8f7d7e024705eadd7655", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e7903d5e592b01e858459adbf2499eb51bde90a52bd27a3f41d14d137062b731138c4884b928860bf0d07391203af348e2cb04db09ce232bdbb02f6400a5032"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-27 01:45:25.262811) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 01:45:25.263113) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1495858813.155868-861733865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 01:45:25.345263) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-27 01:45:25.345582) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-27 01:45:25.345862) ========= ========= Total master_lag: 0.15 =========