builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-070 starttime: 1500988262.88 results: success (0) revision: 07484bfdb96bc7297c404e377eea93f1d8ca4442 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-25 06:11:02.880205) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-25 06:11:02.880662) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-25 06:11:02.880970) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-25 06:11:02.941184) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 06:11:02.941479) ========= 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=2432103b8b3de4003b23cad4000001c2-1500986867.599003-1155191702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-25 06:11:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.7M=0s 2017-07-25 06:11:03 (39.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.161633 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 06:11:03.142643) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 06:11:03.142955) ========= 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=2432103b8b3de4003b23cad4000001c2-1500986867.599003-1155191702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022669 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 06:11:03.201467) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-25 06:11:03.201760) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 07484bfdb96bc7297c404e377eea93f1d8ca4442 --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 07484bfdb96bc7297c404e377eea93f1d8ca4442 --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=2432103b8b3de4003b23cad4000001c2-1500986867.599003-1155191702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-25 06:11:03,454 truncating revision to first 12 chars 2017-07-25 06:11:03,454 Setting DEBUG logging. 2017-07-25 06:11:03,454 attempt 1/10 2017-07-25 06:11:03,454 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/07484bfdb96b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-25 06:11:04,650 unpacking tar archive at: mozilla-central-07484bfdb96b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.499523 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-25 06:11:04.726389) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-25 06:11:04.726709) ========= script_repo_revision: 07484bfdb96bc7297c404e377eea93f1d8ca4442 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-25 06:11:04.727091) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-25 06:11:04.727366) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-25 06:11:04.737193) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-07-25 06:11:04.737504) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2432103b8b3de4003b23cad4000001c2-1500986867.599003-1155191702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:11:05 INFO - MultiFileLogger online at 20170725 06:11:05 in /builds/slave/test 06:11:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:11:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:11:05 INFO - {'append_to_log': False, 06:11:05 INFO - 'base_work_dir': '/builds/slave/test', 06:11:05 INFO - 'blob_upload_branch': 'Firefox', 06:11:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:11:05 INFO - 'branch': 'Firefox', 06:11:05 INFO - 'buildbot_json_path': 'buildprops.json', 06:11:05 INFO - 'code_coverage': False, 06:11:05 INFO - 'config_files': ('talos/linux_config.py',), 06:11:05 INFO - 'default_actions': ('clobber', 06:11:05 INFO - 'read-buildbot-config', 06:11:05 INFO - 'download-and-extract', 06:11:05 INFO - 'populate-webroot', 06:11:05 INFO - 'create-virtualenv', 06:11:05 INFO - 'install', 06:11:05 INFO - 'setup-mitmproxy', 06:11:05 INFO - 'run-tests'), 06:11:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:11:05 INFO - 'disable_ccov_upload': False, 06:11:05 INFO - 'download_minidump_stackwalk': True, 06:11:05 INFO - 'download_symbols': 'ondemand', 06:11:05 INFO - 'enable_stylo': False, 06:11:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:11:05 INFO - 'tooltool.py': '/tools/tooltool.py', 06:11:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:11:05 INFO - '/tools/misc-python/virtualenv.py')}, 06:11:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:11:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:11:05 INFO - 'gecko_profile': False, 06:11:05 INFO - 'gecko_profile_interval': 0, 06:11:05 INFO - 'installer_path': 'installer.exe', 06:11:05 INFO - 'log_level': 'info', 06:11:05 INFO - 'log_name': 'talos', 06:11:05 INFO - 'log_to_console': True, 06:11:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:11:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:11:05 INFO - 'opt_config_files': (), 06:11:05 INFO - 'pip_index': False, 06:11:05 INFO - 'suite': 'dromaeojs-e10s', 06:11:05 INFO - 'system_bits': '32', 06:11:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:11:05 INFO - 'title': 'talos-linux64-ix-070', 06:11:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:11:05 INFO - 'use_talos_json': True, 06:11:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:11:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:11:05 INFO - 'work_dir': 'build'} 06:11:05 INFO - [mozharness: 2017-07-25 13:11:05.087456Z] Running clobber step. 06:11:05 INFO - Running pre-action listener: _resource_record_pre_action 06:11:05 INFO - Running main action method: clobber 06:11:05 INFO - rmtree: /builds/slave/test/build 06:11:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:11:06 INFO - Running post-action listener: _resource_record_post_action 06:11:06 INFO - [mozharness: 2017-07-25 13:11:06.122864Z] Finished clobber step (success) 06:11:06 INFO - [mozharness: 2017-07-25 13:11:06.122967Z] Running read-buildbot-config step. 06:11:06 INFO - Running pre-action listener: _resource_record_pre_action 06:11:06 INFO - Running main action method: read_buildbot_config 06:11:06 INFO - Using buildbot properties: 06:11:06 INFO - { 06:11:06 INFO - "project": "", 06:11:06 INFO - "product": "firefox", 06:11:06 INFO - "who": "cbook@mozilla.com", 06:11:06 INFO - "installer_path": "public/build/target.tar.bz2", 06:11:06 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 06:11:06 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 06:11:06 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 06:11:06 INFO - "stage_platform": "linux64-stylo", 06:11:06 INFO - "basedir": "/builds/slave/test", 06:11:06 INFO - "buildnumber": 0, 06:11:06 INFO - "platform": "ubuntu64_hw_stylo", 06:11:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:11:06 INFO - "slavebuilddir": "test", 06:11:06 INFO - "taskId": "As0M6d4xT2ujnIRYxMKmFw", 06:11:06 INFO - "branch": "mozilla-central", 06:11:06 INFO - "script_repo_revision": "production", 06:11:06 INFO - "revision": "07484bfdb96bc7297c404e377eea93f1d8ca4442", 06:11:06 INFO - "slavename": "talos-linux64-ix-070", 06:11:06 INFO - "repo_path": "mozilla-central" 06:11:06 INFO - } 06:11:06 INFO - Finding installer, test and symbols from parent task. 06:11:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/As0M6d4xT2ujnIRYxMKmFw'}, attempt #1 06:11:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/As0M6d4xT2ujnIRYxMKmFw'}, attempt #1 06:11:07 INFO - Task dependencies: blOgpJOoQfmX7a7f7IMY-A 06:11:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A'}, attempt #1 06:11:07 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.tar.bz2 06:11:07 INFO - Set test_url: https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/test_packages.json 06:11:07 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.crashreporter-symbols.zip 06:11:07 INFO - Running post-action listener: _resource_record_post_action 06:11:07 INFO - [mozharness: 2017-07-25 13:11:07.479528Z] Finished read-buildbot-config step (success) 06:11:07 INFO - [mozharness: 2017-07-25 13:11:07.479751Z] Running download-and-extract step. 06:11:07 INFO - Running pre-action listener: _resource_record_pre_action 06:11:07 INFO - Running main action method: download_and_extract 06:11:07 INFO - mkdir: /builds/slave/test/build/tests 06:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:07 INFO - trying https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.test_packages.json 06:11:07 INFO - Downloading https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:11:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:11:08 INFO - Downloaded 989 bytes. 06:11:08 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:11:08 INFO - Using the following test package requirements: 06:11:08 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:11:08 INFO - u'common': [u'target.common.tests.zip'], 06:11:08 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:11:08 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:11:08 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:11:08 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:11:08 INFO - u'mozbase': [u'target.common.tests.zip'], 06:11:08 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:11:08 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:11:08 INFO - u'web-platform': [u'target.common.tests.zip', 06:11:08 INFO - u'target.web-platform.tests.tar.gz'], 06:11:08 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:11:08 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:11:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.common.tests.zip 06:11:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:11:08 INFO - Fetch https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.common.tests.zip into memory 06:11:16 INFO - Content-Length response header: 72762042 06:11:16 INFO - Bytes received: 72762042 06:11:27 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:11:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.common.tests.zip 06:11:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:11:27 INFO - Fetch https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.common.tests.zip into memory 06:11:31 INFO - Content-Length response header: 72762042 06:11:31 INFO - Bytes received: 72762042 06:11:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.talos.tests.zip 06:11:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:11:43 INFO - Fetch https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.talos.tests.zip into memory 06:11:44 INFO - Content-Length response header: 14498866 06:11:44 INFO - Bytes received: 14498866 06:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:44 INFO - trying https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.tar.bz2 06:11:44 INFO - Downloading https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:11:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:11:47 INFO - Downloaded 62009754 bytes. 06:11:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.tar.bz2 06:11:47 INFO - mkdir: /builds/slave/test/properties 06:11:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:11:47 INFO - Writing to file /builds/slave/test/properties/build_url 06:11:47 INFO - Contents: 06:11:47 INFO - build_url:https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.tar.bz2 06:11:47 INFO - Running post-action listener: _resource_record_post_action 06:11:47 INFO - Running post-action listener: set_extra_try_arguments 06:11:47 INFO - [mozharness: 2017-07-25 13:11:47.951671Z] Finished download-and-extract step (success) 06:11:47 INFO - [mozharness: 2017-07-25 13:11:47.951901Z] Running populate-webroot step. 06:11:47 INFO - Running pre-action listener: _resource_record_pre_action 06:11:47 INFO - Running main action method: populate_webroot 06:11:47 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:11:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:11:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:11:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:11:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:11:47 INFO - 'tests': ['damp', 'tps']}, 06:11:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:11:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 06:11:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 06:11:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 06:11:47 INFO - 'other-e10s': {'tests': ['a11yr', 06:11:47 INFO - 'ts_paint', 06:11:47 INFO - 'tpaint', 06:11:47 INFO - 'sessionrestore', 06:11:47 INFO - 'sessionrestore_many_windows', 06:11:47 INFO - 'sessionrestore_no_auto_restore', 06:11:47 INFO - 'tabpaint']}, 06:11:47 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 06:11:47 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 06:11:47 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:11:47 INFO - 'talos_options': ['--mitmproxy', 06:11:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:11:47 INFO - '--firstNonBlankPaint'], 06:11:47 INFO - 'tests': ['quantum_pageload_google', 06:11:47 INFO - 'quantum_pageload_youtube', 06:11:47 INFO - 'quantum_pageload_amazon', 06:11:47 INFO - 'quantum_pageload_facebook']}, 06:11:47 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:11:47 INFO - 'talos_options': ['--stylo', 06:11:47 INFO - '--mitmproxy', 06:11:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:11:47 INFO - '--firstNonBlankPaint'], 06:11:47 INFO - 'tests': ['quantum_pageload_google', 06:11:47 INFO - 'quantum_pageload_youtube', 06:11:47 INFO - 'quantum_pageload_amazon', 06:11:47 INFO - 'quantum_pageload_facebook']}, 06:11:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:11:47 INFO - 'tsvgr_opacity', 06:11:47 INFO - 'tart', 06:11:47 INFO - 'tscrollx', 06:11:47 INFO - 'cart', 06:11:47 INFO - 'tsvg_static']}, 06:11:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:11:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:11:47 INFO - 'talos_options': ['--xperf_path', 06:11:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:11:47 INFO - 'tests': ['tp5n']}}} 06:11:47 INFO - Running post-action listener: _resource_record_post_action 06:11:47 INFO - [mozharness: 2017-07-25 13:11:47.965248Z] Finished populate-webroot step (success) 06:11:47 INFO - [mozharness: 2017-07-25 13:11:47.965339Z] Running create-virtualenv step. 06:11:47 INFO - Running pre-action listener: _resource_record_pre_action 06:11:47 INFO - Running main action method: create_virtualenv 06:11:47 INFO - Creating virtualenv /builds/slave/test/build/venv 06:11:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:11:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:11:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 06:11:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:11:48 INFO - Using real prefix '/usr' 06:11:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:11:48 INFO - Installing distribute.............................................................................................................................................................................................done. 06:11:50 INFO - Installing pip.................done. 06:11:50 INFO - Return code: 0 06:11:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:11:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:11:50 INFO - Reading from file tmpfile_stdout 06:11:50 INFO - Output received: 06:11:50 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 06:11:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:50 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 0x1a591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c25a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc8d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc5eb0>, '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 0x1dc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc7240>, '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': '2432103b8b3de4003b23cad4000001c2-1500986867.599003-1155191702', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:11:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:11:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:11:50 INFO - Using env: {'DISPLAY': ':0', 06:11:50 INFO - 'HOME': '/home/cltbld', 06:11:50 INFO - 'LANG': 'en_US.UTF-8', 06:11:50 INFO - 'LANGUAGE': 'en_US:en', 06:11:50 INFO - 'LOGNAME': 'cltbld', 06:11:50 INFO - 'MAIL': '/var/mail/cltbld', 06:11:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:50 INFO - 'MOZ_NO_REMOTE': '1', 06:11:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:50 INFO - 'NO_EM_RESTART': '1', 06:11:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:50 INFO - 'PWD': '/builds/slave/test', 06:11:50 INFO - 'SHELL': '/bin/bash', 06:11:50 INFO - 'SHLVL': '1', 06:11:50 INFO - 'TERM': 'linux', 06:11:50 INFO - 'TMOUT': '86400', 06:11:50 INFO - 'USER': 'cltbld', 06:11:50 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1500986867.599003-1155191702', 06:11:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:50 INFO - '_': '/tools/buildbot/bin/python'} 06:11:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:11:50 INFO - Cleaning up... 06:11:50 INFO - Return code: 0 06:11:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:50 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 0x1a591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c25a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc8d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc5eb0>, '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 0x1dc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc7240>, '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': '2432103b8b3de4003b23cad4000001c2-1500986867.599003-1155191702', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:11:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:11:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:11:50 INFO - Using env: {'DISPLAY': ':0', 06:11:50 INFO - 'HOME': '/home/cltbld', 06:11:50 INFO - 'LANG': 'en_US.UTF-8', 06:11:50 INFO - 'LANGUAGE': 'en_US:en', 06:11:50 INFO - 'LOGNAME': 'cltbld', 06:11:50 INFO - 'MAIL': '/var/mail/cltbld', 06:11:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:50 INFO - 'MOZ_NO_REMOTE': '1', 06:11:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:50 INFO - 'NO_EM_RESTART': '1', 06:11:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:50 INFO - 'PWD': '/builds/slave/test', 06:11:50 INFO - 'SHELL': '/bin/bash', 06:11:50 INFO - 'SHLVL': '1', 06:11:50 INFO - 'TERM': 'linux', 06:11:50 INFO - 'TMOUT': '86400', 06:11:50 INFO - 'USER': 'cltbld', 06:11:50 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1500986867.599003-1155191702', 06:11:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:50 INFO - '_': '/tools/buildbot/bin/python'} 06:11:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:51 INFO - Downloading/unpacking psutil>=3.1.1 06:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:11:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:11:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:11:52 INFO - Installing collected packages: psutil 06:11:52 INFO - Running setup.py install for psutil 06:11:52 INFO - building 'psutil._psutil_linux' extension 06:11:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:11:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:11:52 INFO - building 'psutil._psutil_posix' extension 06:11:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:11:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:11:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:11:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:11:52 INFO - Successfully installed psutil 06:11:52 INFO - Cleaning up... 06:11:52 INFO - Return code: 0 06:11:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c25a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc8d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc5eb0>, '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 0x1dc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc7240>, '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': '2432103b8b3de4003b23cad4000001c2-1500986867.599003-1155191702', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:11:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:11:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:11:52 INFO - Using env: {'DISPLAY': ':0', 06:11:52 INFO - 'HOME': '/home/cltbld', 06:11:52 INFO - 'LANG': 'en_US.UTF-8', 06:11:52 INFO - 'LANGUAGE': 'en_US:en', 06:11:52 INFO - 'LOGNAME': 'cltbld', 06:11:52 INFO - 'MAIL': '/var/mail/cltbld', 06:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:52 INFO - 'MOZ_NO_REMOTE': '1', 06:11:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:52 INFO - 'NO_EM_RESTART': '1', 06:11:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:52 INFO - 'PWD': '/builds/slave/test', 06:11:52 INFO - 'SHELL': '/bin/bash', 06:11:52 INFO - 'SHLVL': '1', 06:11:52 INFO - 'TERM': 'linux', 06:11:52 INFO - 'TMOUT': '86400', 06:11:52 INFO - 'USER': 'cltbld', 06:11:52 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1500986867.599003-1155191702', 06:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:52 INFO - '_': '/tools/buildbot/bin/python'} 06:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:11:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:11:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:11:54 INFO - Installing collected packages: mozsystemmonitor 06:11:54 INFO - Running setup.py install for mozsystemmonitor 06:11:54 INFO - Successfully installed mozsystemmonitor 06:11:54 INFO - Cleaning up... 06:11:54 INFO - Return code: 0 06:11:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1a591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c25a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc8d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc5eb0>, '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 0x1dc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc7240>, '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': '2432103b8b3de4003b23cad4000001c2-1500986867.599003-1155191702', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:11:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:11:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:11:54 INFO - Using env: {'DISPLAY': ':0', 06:11:54 INFO - 'HOME': '/home/cltbld', 06:11:54 INFO - 'LANG': 'en_US.UTF-8', 06:11:54 INFO - 'LANGUAGE': 'en_US:en', 06:11:54 INFO - 'LOGNAME': 'cltbld', 06:11:54 INFO - 'MAIL': '/var/mail/cltbld', 06:11:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:54 INFO - 'MOZ_NO_REMOTE': '1', 06:11:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:54 INFO - 'NO_EM_RESTART': '1', 06:11:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:54 INFO - 'PWD': '/builds/slave/test', 06:11:54 INFO - 'SHELL': '/bin/bash', 06:11:54 INFO - 'SHLVL': '1', 06:11:54 INFO - 'TERM': 'linux', 06:11:54 INFO - 'TMOUT': '86400', 06:11:54 INFO - 'USER': 'cltbld', 06:11:54 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1500986867.599003-1155191702', 06:11:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:54 INFO - '_': '/tools/buildbot/bin/python'} 06:11:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:54 INFO - Downloading/unpacking jsonschema==2.5.1 06:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:11:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:55 INFO - Downloading functools32-3.2.3-2.tar.gz 06:11:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:11:55 INFO - warning: no files found matching '*.txt' 06:11:55 INFO - no previously-included directories found matching 'build' 06:11:55 INFO - no previously-included directories found matching 'dist' 06:11:55 INFO - no previously-included directories found matching '.git*' 06:11:55 INFO - Installing collected packages: jsonschema, functools32 06:11:55 INFO - Running setup.py install for functools32 06:11:56 INFO - warning: no files found matching '*.txt' 06:11:56 INFO - no previously-included directories found matching 'build' 06:11:56 INFO - no previously-included directories found matching 'dist' 06:11:56 INFO - no previously-included directories found matching '.git*' 06:11:56 INFO - Successfully installed jsonschema functools32 06:11:56 INFO - Cleaning up... 06:11:56 INFO - Return code: 0 06:11:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:11:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:56 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 0x1a591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c25a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc8d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc5eb0>, '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 0x1dc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc7240>, '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': '2432103b8b3de4003b23cad4000001c2-1500986867.599003-1155191702', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:11:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:11:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:11:56 INFO - Using env: {'DISPLAY': ':0', 06:11:56 INFO - 'HOME': '/home/cltbld', 06:11:56 INFO - 'LANG': 'en_US.UTF-8', 06:11:56 INFO - 'LANGUAGE': 'en_US:en', 06:11:56 INFO - 'LOGNAME': 'cltbld', 06:11:56 INFO - 'MAIL': '/var/mail/cltbld', 06:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:56 INFO - 'MOZ_NO_REMOTE': '1', 06:11:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:56 INFO - 'NO_EM_RESTART': '1', 06:11:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:56 INFO - 'PWD': '/builds/slave/test', 06:11:56 INFO - 'SHELL': '/bin/bash', 06:11:56 INFO - 'SHLVL': '1', 06:11:56 INFO - 'TERM': 'linux', 06:11:56 INFO - 'TMOUT': '86400', 06:11:56 INFO - 'USER': 'cltbld', 06:11:56 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1500986867.599003-1155191702', 06:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:56 INFO - '_': '/tools/buildbot/bin/python'} 06:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:11:56 INFO - Cleaning up... 06:11:56 INFO - Return code: 0 06:11:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:11:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:56 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 0x1a591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c25a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc8d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc5eb0>, '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 0x1dc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc7240>, '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': '2432103b8b3de4003b23cad4000001c2-1500986867.599003-1155191702', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:11:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:11:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:11:56 INFO - Using env: {'DISPLAY': ':0', 06:11:56 INFO - 'HOME': '/home/cltbld', 06:11:56 INFO - 'LANG': 'en_US.UTF-8', 06:11:56 INFO - 'LANGUAGE': 'en_US:en', 06:11:56 INFO - 'LOGNAME': 'cltbld', 06:11:56 INFO - 'MAIL': '/var/mail/cltbld', 06:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:56 INFO - 'MOZ_NO_REMOTE': '1', 06:11:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:56 INFO - 'NO_EM_RESTART': '1', 06:11:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:56 INFO - 'PWD': '/builds/slave/test', 06:11:56 INFO - 'SHELL': '/bin/bash', 06:11:56 INFO - 'SHLVL': '1', 06:11:56 INFO - 'TERM': 'linux', 06:11:56 INFO - 'TMOUT': '86400', 06:11:56 INFO - 'USER': 'cltbld', 06:11:56 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1500986867.599003-1155191702', 06:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:56 INFO - '_': '/tools/buildbot/bin/python'} 06:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:56 INFO - Downloading/unpacking blobuploader==1.2.4 06:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:57 INFO - Downloading blobuploader-1.2.4.tar.gz 06:11:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:11:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:11:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:58 INFO - Downloading docopt-0.6.1.tar.gz 06:11:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:11:58 INFO - Installing collected packages: blobuploader, requests, docopt 06:11:58 INFO - Running setup.py install for blobuploader 06:11:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:11:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:11:58 INFO - Running setup.py install for requests 06:11:58 INFO - Running setup.py install for docopt 06:11:58 INFO - Successfully installed blobuploader requests docopt 06:11:58 INFO - Cleaning up... 06:11:58 INFO - Return code: 0 06:11:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:58 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 0x1a591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c25a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc8d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc5eb0>, '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 0x1dc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc7240>, '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': '2432103b8b3de4003b23cad4000001c2-1500986867.599003-1155191702', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:11:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:11:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:11:58 INFO - Using env: {'DISPLAY': ':0', 06:11:58 INFO - 'HOME': '/home/cltbld', 06:11:58 INFO - 'LANG': 'en_US.UTF-8', 06:11:58 INFO - 'LANGUAGE': 'en_US:en', 06:11:58 INFO - 'LOGNAME': 'cltbld', 06:11:58 INFO - 'MAIL': '/var/mail/cltbld', 06:11:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:58 INFO - 'MOZ_NO_REMOTE': '1', 06:11:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:58 INFO - 'NO_EM_RESTART': '1', 06:11:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:58 INFO - 'PWD': '/builds/slave/test', 06:11:58 INFO - 'SHELL': '/bin/bash', 06:11:58 INFO - 'SHLVL': '1', 06:11:58 INFO - 'TERM': 'linux', 06:11:58 INFO - 'TMOUT': '86400', 06:11:58 INFO - 'USER': 'cltbld', 06:11:58 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1500986867.599003-1155191702', 06:11:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:58 INFO - '_': '/tools/buildbot/bin/python'} 06:11:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:11:59 INFO - Running setup.py (path:/tmp/pip-sqRm84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:11:59 INFO - Running setup.py (path:/tmp/pip-h5XLAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:11:59 INFO - Running setup.py (path:/tmp/pip-XQWJSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:11:59 INFO - Running setup.py (path:/tmp/pip-IoWiwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:11:59 INFO - Running setup.py (path:/tmp/pip-999zA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:11:59 INFO - Running setup.py (path:/tmp/pip-9xvJBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:11:59 INFO - Running setup.py (path:/tmp/pip-tQEd3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:11:59 INFO - Running setup.py (path:/tmp/pip-7T1pbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:11:59 INFO - Running setup.py (path:/tmp/pip-djgL0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:11:59 INFO - Running setup.py (path:/tmp/pip-bTPZSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:11:59 INFO - Running setup.py (path:/tmp/pip-w6RGB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:11:59 INFO - Running setup.py (path:/tmp/pip-5mBluj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:11:59 INFO - Running setup.py (path:/tmp/pip-0RXfdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:11:59 INFO - Running setup.py (path:/tmp/pip-YX2s13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:12:00 INFO - Running setup.py (path:/tmp/pip-65LwHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:12:00 INFO - Running setup.py (path:/tmp/pip-pX_l22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:12:00 INFO - Running setup.py (path:/tmp/pip-QS9_kZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:12:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:12:00 INFO - Running setup.py install for manifestparser 06:12:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:12:00 INFO - Running setup.py install for mozcrash 06:12:00 INFO - Running setup.py install for mozdebug 06:12:00 INFO - Running setup.py install for mozdevice 06:12:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:12:00 INFO - Running setup.py install for mozfile 06:12:00 INFO - Running setup.py install for mozhttpd 06:12:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:12:00 INFO - Running setup.py install for mozinfo 06:12:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:12:00 INFO - Running setup.py install for mozInstall 06:12:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:12:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:12:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:12:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:12:01 INFO - Running setup.py install for mozleak 06:12:01 INFO - Running setup.py install for mozlog 06:12:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:12:01 INFO - Running setup.py install for moznetwork 06:12:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:12:01 INFO - Running setup.py install for mozprocess 06:12:01 INFO - Running setup.py install for mozprofile 06:12:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:12:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:12:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:12:01 INFO - Running setup.py install for mozrunner 06:12:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:12:01 INFO - Running setup.py install for mozscreenshot 06:12:01 INFO - Running setup.py install for moztest 06:12:01 INFO - Running setup.py install for mozversion 06:12:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:12:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:12:02 INFO - Cleaning up... 06:12:02 INFO - Return code: 0 06:12:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:12:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:02 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 0x1a591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c25a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc8d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc5eb0>, '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 0x1dc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc7240>, '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': '2432103b8b3de4003b23cad4000001c2-1500986867.599003-1155191702', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:12:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:12:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:12:02 INFO - Using env: {'DISPLAY': ':0', 06:12:02 INFO - 'HOME': '/home/cltbld', 06:12:02 INFO - 'LANG': 'en_US.UTF-8', 06:12:02 INFO - 'LANGUAGE': 'en_US:en', 06:12:02 INFO - 'LOGNAME': 'cltbld', 06:12:02 INFO - 'MAIL': '/var/mail/cltbld', 06:12:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:02 INFO - 'MOZ_NO_REMOTE': '1', 06:12:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:02 INFO - 'NO_EM_RESTART': '1', 06:12:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:02 INFO - 'PWD': '/builds/slave/test', 06:12:02 INFO - 'SHELL': '/bin/bash', 06:12:02 INFO - 'SHLVL': '1', 06:12:02 INFO - 'TERM': 'linux', 06:12:02 INFO - 'TMOUT': '86400', 06:12:02 INFO - 'USER': 'cltbld', 06:12:02 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1500986867.599003-1155191702', 06:12:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:02 INFO - '_': '/tools/buildbot/bin/python'} 06:12:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:12:02 INFO - Running setup.py (path:/tmp/pip-lswWod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:12:02 INFO - Running setup.py (path:/tmp/pip-Jg_z6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:12:02 INFO - Running setup.py (path:/tmp/pip-9RAxV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:12:02 INFO - Running setup.py (path:/tmp/pip-KPr41Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:12:02 INFO - Running setup.py (path:/tmp/pip-GF3wha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:12:02 INFO - Running setup.py (path:/tmp/pip-FLT8YR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:12:02 INFO - Running setup.py (path:/tmp/pip-Piy5hA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:12:02 INFO - Running setup.py (path:/tmp/pip-DDRnVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:12:02 INFO - Running setup.py (path:/tmp/pip-paEHKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:12:02 INFO - Running setup.py (path:/tmp/pip-N0o4FE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:12:03 INFO - Running setup.py (path:/tmp/pip-fSg5uN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:12:03 INFO - Running setup.py (path:/tmp/pip-6c1qUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:12:03 INFO - Running setup.py (path:/tmp/pip-953SzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:12:03 INFO - Running setup.py (path:/tmp/pip-tNOupT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:12:03 INFO - Running setup.py (path:/tmp/pip-oKc6uj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:12:03 INFO - Running setup.py (path:/tmp/pip-gzPtKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:12:03 INFO - Running setup.py (path:/tmp/pip-3BvNI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:12:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:04 INFO - Downloading blessings-1.6.tar.gz 06:12:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:12:04 INFO - Installing collected packages: blessings 06:12:04 INFO - Running setup.py install for blessings 06:12:04 INFO - Successfully installed blessings 06:12:04 INFO - Cleaning up... 06:12:04 INFO - Return code: 0 06:12:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:12:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:12:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:12:05 INFO - Reading from file tmpfile_stdout 06:12:05 INFO - Current package versions: 06:12:05 INFO - argparse == 1.2.1 06:12:05 INFO - blessings == 1.6 06:12:05 INFO - blobuploader == 1.2.4 06:12:05 INFO - docopt == 0.6.1 06:12:05 INFO - functools32 == 3.2.3-2 06:12:05 INFO - jsonschema == 2.5.1 06:12:05 INFO - manifestparser == 1.1 06:12:05 INFO - mozInstall == 1.13 06:12:05 INFO - mozcrash == 1.0 06:12:05 INFO - mozdebug == 0.1 06:12:05 INFO - mozdevice == 0.51 06:12:05 INFO - mozfile == 1.2 06:12:05 INFO - mozhttpd == 0.7 06:12:05 INFO - mozinfo == 0.10 06:12:05 INFO - mozleak == 0.1 06:12:05 INFO - mozlog == 3.5 06:12:05 INFO - moznetwork == 0.27 06:12:05 INFO - mozprocess == 0.25 06:12:05 INFO - mozprofile == 0.28 06:12:05 INFO - mozrunner == 6.13 06:12:05 INFO - mozscreenshot == 0.1 06:12:05 INFO - mozsystemmonitor == 0.3 06:12:05 INFO - moztest == 0.8 06:12:05 INFO - mozversion == 1.4 06:12:05 INFO - psutil == 3.1.1 06:12:05 INFO - requests == 1.2.3 06:12:05 INFO - wsgiref == 0.1.2 06:12:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:12: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')]} 06:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12: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')]} 06:12:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:05 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 0x1a591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c25a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc8d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc5eb0>, '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 0x1dc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc7240>, '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': '2432103b8b3de4003b23cad4000001c2-1500986867.599003-1155191702', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:12:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:12:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:12:05 INFO - Using env: {'DISPLAY': ':0', 06:12:05 INFO - 'HOME': '/home/cltbld', 06:12:05 INFO - 'LANG': 'en_US.UTF-8', 06:12:05 INFO - 'LANGUAGE': 'en_US:en', 06:12:05 INFO - 'LOGNAME': 'cltbld', 06:12:05 INFO - 'MAIL': '/var/mail/cltbld', 06:12:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:05 INFO - 'MOZ_NO_REMOTE': '1', 06:12:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:05 INFO - 'NO_EM_RESTART': '1', 06:12:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:05 INFO - 'PWD': '/builds/slave/test', 06:12:05 INFO - 'SHELL': '/bin/bash', 06:12:05 INFO - 'SHLVL': '1', 06:12:05 INFO - 'TERM': 'linux', 06:12:05 INFO - 'TMOUT': '86400', 06:12:05 INFO - 'USER': 'cltbld', 06:12:05 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1500986867.599003-1155191702', 06:12:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:05 INFO - '_': '/tools/buildbot/bin/python'} 06:12:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:12:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:12:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:12:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:12:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:12:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:12:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:12:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:12:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:12:05 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 06:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:06 INFO - Downloading marionette_driver-1.4.0.tar.gz 06:12:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 06:12:06 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 06:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 06:12:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:12:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:12:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 06:12:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 06:12:06 INFO - Installing collected packages: marionette-driver, simplejson 06:12:06 INFO - Running setup.py install for marionette-driver 06:12:06 INFO - Running setup.py install for simplejson 06:12:06 INFO - building 'simplejson._speedups' extension 06:12:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 06:12:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 06:12:07 INFO - Successfully installed marionette-driver simplejson 06:12:07 INFO - Cleaning up... 06:12:07 INFO - Return code: 0 06:12:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:12:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c25a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc8d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc5eb0>, '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 0x1dc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc7240>, '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': '2432103b8b3de4003b23cad4000001c2-1500986867.599003-1155191702', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:12:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:12:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:12:07 INFO - Using env: {'DISPLAY': ':0', 06:12:07 INFO - 'HOME': '/home/cltbld', 06:12:07 INFO - 'LANG': 'en_US.UTF-8', 06:12:07 INFO - 'LANGUAGE': 'en_US:en', 06:12:07 INFO - 'LOGNAME': 'cltbld', 06:12:07 INFO - 'MAIL': '/var/mail/cltbld', 06:12:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:07 INFO - 'MOZ_NO_REMOTE': '1', 06:12:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:07 INFO - 'NO_EM_RESTART': '1', 06:12:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:07 INFO - 'PWD': '/builds/slave/test', 06:12:07 INFO - 'SHELL': '/bin/bash', 06:12:07 INFO - 'SHLVL': '1', 06:12:07 INFO - 'TERM': 'linux', 06:12:07 INFO - 'TMOUT': '86400', 06:12:07 INFO - 'USER': 'cltbld', 06:12:07 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1500986867.599003-1155191702', 06:12:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:07 INFO - '_': '/tools/buildbot/bin/python'} 06:12:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:12:08 INFO - Cleaning up... 06:12:08 INFO - Return code: 0 06:12:08 INFO - Running post-action listener: _resource_record_post_action 06:12:08 INFO - Running post-action listener: _start_resource_monitoring 06:12:08 INFO - Starting resource monitoring. 06:12:08 INFO - [mozharness: 2017-07-25 13:12:08.147161Z] Finished create-virtualenv step (success) 06:12:08 INFO - [mozharness: 2017-07-25 13:12:08.147691Z] Running install step. 06:12:08 INFO - Running pre-action listener: _resource_record_pre_action 06:12:08 INFO - Running main action method: install 06:12:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:12:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:12:08 INFO - Reading from file tmpfile_stdout 06:12:08 INFO - Detecting whether we're running mozinstall >=1.0... 06:12:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:12:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:12:08 INFO - Reading from file tmpfile_stdout 06:12:08 INFO - Output received: 06:12:08 INFO - Usage: mozinstall [options] installer 06:12:08 INFO - Options: 06:12:08 INFO - -h, --help show this help message and exit 06:12:08 INFO - -d DEST, --destination=DEST 06:12:08 INFO - Directory to install application into. [default: 06:12:08 INFO - "/builds/slave/test"] 06:12:08 INFO - --app=APP Application being installed. [default: firefox] 06:12:08 INFO - mkdir: /builds/slave/test/build/application 06:12:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:12:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:12:26 INFO - Reading from file tmpfile_stdout 06:12:26 INFO - Output received: 06:12:26 INFO - /builds/slave/test/build/application/firefox/firefox 06:12:26 INFO - Running post-action listener: _resource_record_post_action 06:12:26 INFO - [mozharness: 2017-07-25 13:12:26.468571Z] Finished install step (success) 06:12:26 INFO - [mozharness: 2017-07-25 13:12:26.468826Z] Running setup-mitmproxy step. 06:12:26 INFO - Running pre-action listener: _resource_record_pre_action 06:12:26 INFO - Running main action method: setup_mitmproxy 06:12:26 INFO - Skipping: mitmproxy is not required 06:12:26 INFO - Running post-action listener: _resource_record_post_action 06:12:26 INFO - [mozharness: 2017-07-25 13:12:26.470033Z] Finished setup-mitmproxy step (success) 06:12:26 INFO - [mozharness: 2017-07-25 13:12:26.470257Z] Running run-tests step. 06:12:26 INFO - Running pre-action listener: _resource_record_pre_action 06:12:26 INFO - Running pre-action listener: _set_gcov_prefix 06:12:26 INFO - Running main action method: run_tests 06:12:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:12:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:12:26 INFO - Python 2.7.3 06:12:26 INFO - Return code: 0 06:12:26 INFO - grabbing minidump binary from tooltool 06:12: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')]} 06:12:26 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 0x1dc5eb0>, '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 0x1dc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc7240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:12:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:12:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:12:26 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:12:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:12:26 INFO - Return code: 0 06:12:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:12:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:12:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:12:26 INFO - ENV: RUST_BACKTRACE is now 1 06:12:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:12:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:12:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-070', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:12:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-070 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:12:26 INFO - Using env: {'DISPLAY': ':0', 06:12:26 INFO - 'HOME': '/home/cltbld', 06:12:26 INFO - 'LANG': 'en_US.UTF-8', 06:12:26 INFO - 'LANGUAGE': 'en_US:en', 06:12:26 INFO - 'LOGNAME': 'cltbld', 06:12:26 INFO - 'MAIL': '/var/mail/cltbld', 06:12:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:12:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:12:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:26 INFO - 'MOZ_NO_REMOTE': '1', 06:12:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:12:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:26 INFO - 'NO_EM_RESTART': '1', 06:12:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:26 INFO - 'PWD': '/builds/slave/test', 06:12:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:12:26 INFO - 'RUST_BACKTRACE': '1', 06:12:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 06:12:26 INFO - 'SHELL': '/bin/bash', 06:12:26 INFO - 'SHLVL': '1', 06:12:26 INFO - 'STYLO_FORCE_ENABLED': '1', 06:12:26 INFO - 'TERM': 'linux', 06:12:26 INFO - 'TMOUT': '86400', 06:12:26 INFO - 'USER': 'cltbld', 06:12:26 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1500986867.599003-1155191702', 06:12:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:26 INFO - '_': '/tools/buildbot/bin/python'} 06:12:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-070', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:12:26 INFO - mozversion application_buildid: 20170725122752 06:12:26 INFO - mozversion application_changeset: 07484bfdb96bc7297c404e377eea93f1d8ca4442 06:12:26 INFO - mozversion application_display_name: Nightly 06:12:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:12:26 INFO - mozversion application_name: Firefox 06:12:26 INFO - mozversion application_remotingname: firefox 06:12:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:12:26 INFO - mozversion application_vendor: Mozilla 06:12:26 INFO - mozversion application_version: 56.0a1 06:12:26 INFO - mozversion platform_buildid: 20170725122752 06:12:26 INFO - mozversion platform_changeset: 07484bfdb96bc7297c404e377eea93f1d8ca4442 06:12:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:12:26 INFO - mozversion platform_version: 56.0a1 06:12:26 INFO - using testdate: 1500988346 06:12:26 INFO - actual date: 1500988346 06:12:26 INFO - starting webserver on 'localhost:36213' 06:12:26 INFO - SUITE-START | Running 2 tests 06:12:26 INFO - TEST-START | dromaeo_css 06:12:26 INFO - Initialising browser for dromaeo_css test... 06:12:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36213/getInfo.html -profile /tmp/tmpZb3hQq/profile 06:12:26 INFO - TEST-INFO | started process 14734 (/builds/slave/test/build/application/firefox/firefox http://localhost:36213/getInfo.html) 06:12:32 INFO - TEST-INFO | 14734: exit 0 06:12:32 INFO - Browser initialized. 06:12:32 INFO - Running cycle 1/1 for dromaeo_css test... 06:12:32 INFO - TEST-INFO | started process 14959 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZb3hQq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:12:33 INFO - PID 14959 | 06:12:33 INFO - PID 14959 | (/builds/slave/test/build/application/firefox/firefox:15014): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:12:33 INFO - PID 14959 | 06:12:44 INFO - PID 14959 | RSS: Main: 173740032 06:12:44 INFO - PID 14959 | 06:15:44 INFO - PID 14959 | Cycle 1(1): loaded http://localhost:36213/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36213/tests/dromaeo/cssquery-ext.html) 06:15:45 INFO - PID 14959 | RSS: Main: 175284224 06:15:45 INFO - PID 14959 | 06:18:47 INFO - PID 14959 | Cycle 1(1): loaded http://localhost:36213/tests/dromaeo/cssquery-ext.html (next: http://localhost:36213/tests/dromaeo/cssquery-jquery.html) 06:18:48 INFO - PID 14959 | RSS: Main: 173461504 06:18:48 INFO - PID 14959 | 06:21:49 INFO - PID 14959 | Cycle 1(1): loaded http://localhost:36213/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36213/tests/dromaeo/cssquery-mootools.html) 06:21:50 INFO - PID 14959 | RSS: Main: 174661632 06:21:50 INFO - PID 14959 | 06:24:52 INFO - PID 14959 | Cycle 1(1): loaded http://localhost:36213/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36213/tests/dromaeo/cssquery-prototype.html) 06:24:53 INFO - PID 14959 | RSS: Main: 173203456 06:24:53 INFO - PID 14959 | 06:27:57 INFO - PID 14959 | Cycle 1(1): loaded http://localhost:36213/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36213/tests/dromaeo/cssquery-yui.html) 06:27:57 INFO - PID 14959 | RSS: Main: 174854144 06:27:57 INFO - PID 14959 | 06:30:59 INFO - PID 14959 | Cycle 1(1): loaded http://localhost:36213/tests/dromaeo/cssquery-yui.html (next: http://localhost:36213/tests/dromaeo/cssquery-dojo.html) 06:30:59 INFO - PID 14959 | RSS: Main: 177377280 06:30:59 INFO - PID 14959 | 06:30:59 INFO - PID 14959 | __start_tp_report 06:30:59 INFO - PID 14959 | _x_x_mozilla_page_load 06:30:59 INFO - PID 14959 | _x_x_mozilla_page_load_details 06:30:59 INFO - PID 14959 | |i|pagename|runs| 06:30:59 INFO - PID 14959 | |0;dojo.html;3132.671069537697;3138.701823326784;3170.5719727836736;3174.8730050797976;3196.8561414736337;6192.164057852188;6192.659403732793;6269.592476489025;6276.372362763721;6292.18201633787;6059.242594675666;6181.567290289681;6195.535334849893;6199.473044791198;6209.627422354662;5546.334439867202;5591.6365436246515;5595.804146854841;5596.608237423382;5620.887582248352;5604.243427137325;5649.49154576088;5741.913871291934;5752.079667253241;5773.855653608673;5701.8574535636735;5754.597178197528;5761.625494342854;5767.480926716595;5837.124431335291;5560.054790685553;5647.209390685307;5738.913916291259;5739.3973632768375;5791.565632577553;5360.91958620621;5588.133839254922;5654.123610840326;5700.515456186229;5726.856828579319;6020.247469066367;6093.421124993119;6176.3514830943;6179.443850053517;6193.473554747852;6462.773802916875;6542.214934207878;6561;6571.408573228385;6585.637789921552;6631.7347306107695;6632.502562307846;6632.9336706633285;6644.235912870034;6694.799156025327;6188.84527886802;6201.10084037812;6205.410486003822;6211.503079753609;6217.96891015542;6768.593884366954;6784.59292442455;6843.965780171166;6870.931290687129;6954.965225173943;6455.870882582322;6462.741490340428;6471.644059576674;6547.083408322838;6561.671916404161;6496.187976502937;6610.96694516534;6617.60294382329;6631.966840165768;6643.667816609151;6535.3464653534265;6579.111819904251;6606.042123892009;6619.635920024445;6632.2372927114;6501.0573466847045;6556.147700798866;6566.606003639797;6660.167479065117;6681.164854393201;5244;5282.683039017671;5327.786888524493;5364.356277246756;5370.087085195526;4588.678792484494;4605.585497305258;4606.976965115153;4632.420947381577;4637.721736695809;5637.605367624309;5722.084466485342;5795.188673585617;5800.071988481823;5800.709964501758;6441.259255185713;6497.8700425992165;6647;6702.899456508157;6720.731170753213;5665.6034077614995;5709.115087161496;5788.450097240755;5792.478676919098;5793.420657934257;5812.709364531756;5847.26909136358;5875.059990401515;5889.0871914852405;5915.40845915405;6418.4544313731985;6431.646259455775;6470.2559205691;6523.445507131947;6557.9344206557325;6597.340265973365;6653.833654158685;6676;6678.3989440950545;6740.460763138839;6490.286068532552;6505.186851643544;6560.8359791005605;6567.080608714688;6573.1454910861285;6480.44916182111;6510.641914694548;6538.509611779041;6637.402633762985;6652.368025037614;6671.8665626686225;6714.093597364294;6742.494312926452;6757.966210168917;6762.52662313653;6300.9684951574945;6410.45511131559;6432.9678351607945;6541.574797638138;6553.115329430466;6469.870602587827;6500.154979852589;6511.967440162769;6512;6533.836654083496;6229.0967809668255;6246.156768836331;6303.905441418291;6323.9683801580695;6398.0083087121575;6506.837329066622;6534.705938232886;6577.769778057745;6583.967080164569;6620.8344791380605;6290.811275661737;6308.306086330592;6326.9683651581445;6391.6804159792755;6409.775657852139 06:30:59 INFO - PID 14959 | |1;ext.html;794.5629903553048;849.2993280543552;878.4246318661275;882.1972005475019;1171.7832201042802;31484.527732084036;31983.52024719631;41741.373879391795;43061.35407968883;43066.78466607662;42930.78534607323;43298;43310.13379732404;43399;43442.56557434425;7581.77254682359;7591.81020474487;7806.5316081035035;7808.258215469521;7818.45270831042;7668.194839541851;7768.300852923236;7772.028496437945;7781.182975787546;7784.1437441881635;7758.883616745725;7809.453338266324;7813.062432508107;7814.179511151333;7816.921830781676;7720.3051725344985;7726.459147859652;7761.495502792301;7778.144404115543;7778.8833167502535;7611.771646850603;7647.120581133186;7658.425618078611;7680.462367634268;7697.0378702662165;38767.61232387668;38877.22245555073;38916.416253756215;39090.21819563593;39111.60888391108;3494.0391392367046;3495.0912762681633;3504.56192975878;3532.0816587687127;3538.752287339887;31838;31975.840120799247;31978.84010579932;32077.358452831046;32152;4852.636052296092;4893.04585605807;4901.730404827733;4920.0651876143775;4933.038057578774;185892;186680;187787.12212877834;188491;188741.99999999863;50269.74865125724;50284.49715502798;50389.24416133761;50497.242541361906;50632.24051639228;52024.479755201966;52273.215901761505;52837.47162528326;52844.20733688998;52968.20547691788;13595.388207530486;14051.929740351234;14205.644858878612;14223;14249.430022799179;10972.341659500455;12671.683207919692;12871.935640321739;12981.286029268482;12996.805047924288;14414.351354189086;14571.708565828623;14644.414223431157;14668;14853.183074930766;5928.851778705567;6019.428154325332;6071.635701857903;6091.878162436727;6104.542159337979;949.8432758594754;975.9804803903883;989.2333441582687;989.6486747204783;1009.2632378363835;22981.655275170884;23346.53306933852;23359.88320058389;23435.7656423437;23637.172698955455;943.1794338925179;956.4183170393485;956.5599824080862;976.0142256321167;1103.365564800227;11558.479868405942;11954.772211502846;11968.640940771791;11975;12073.094517911191;235800;237319;237952;238094;238127;52983.20525192125;53823;53907;54016;54039;1388.55566218809;1448.3482432905025;1457.0820383158543;1460.1750011243614;1475.1223022301713;20465.38603841887;21300;21940.780592193874;22001.779982200613;22086.447838804157;33194.66805331916;35250.823745881105;37678.811605941795;37717.81141094277;37761.62238377581;204134;204415;206102;206965;207588;30854;31680.524792127675;31715.524267135548;31854.044378668677;35079.82460087683;44366.3345049831;44379.77810110929;44404.11191776211;44668.55331446644;44872;31976.68023319737;31988.20029499281;33080;33102.5034624476;33173.66826331706;30380.24049398783;32217.680122637168;32253.51619725753;32385.51421728723;32914.67085329116;35525;35626.10934726652;35844.28311433704;36109.63890361063;36165.819170903975;29716.702832971394;30966.690333097282;31663.84168079237;31961.520577190895;32544;21488.677669835277;23535.293941181793;23543.41141471477;23615.763842361357;23916 06:30:59 INFO - PID 14959 | |2;jquery.html;570.7460180219799;575.1746244139663;584.9532037437003;598.2462097756825;602.7016626769748;21951.780482195172;22336.329910102682;23224.187153449613;23227.883860580696;23284;25604.23187304379;26305.736942630567;26351.73648263517;26369.208923732273;26574.867125664394;6502;6576.309487503815;6656.434203092743;6664;6677.8330541736605;5973.761049558012;6556.475481961455;6591.7363305467725;6628.270890202074;6633.834154146137;6498.9025164622335;6516.93483065168;6532.052852336408;6546.279909209983;6554.7705830295945;6538.640374779409;6544.836379090513;6550.0829883816305;6553.574017688835;6555.44278736308;6091.695415229221;6108.480779133779;6110.175126357929;6118.755249790003;6131.325554189036;28755.424891502054;29198.124056278346;29668.531984718513;29716.55425168624;30210.09369718912;1867.82255685711;1922;1922.2695375757123;1924.028365675339;1929.3150931419284;19177.3287934923;19799.40601781949;19841.30555430553;19858.20567177311;19858.70211946822;2362.982226306629;2395.35325462126;2437.2566367257978;2448.755124487555;2466.469709012571;137158;138530;139448;140066;140953;14231.430742770173;15217.847821521864;15266.236688165547;15340.698895165591;15865.286062127232;22769.544609108056;23769.881150594483;24231.273061808173;24242.87878560596;24265.150719724727;9869.11177993984;9879.209663226924;10124.291299609104;10247.38515689061;10336.793264134676;9123.406978546373;9170.220531254918;9191.77020574491;9254.305927055499;9303.441793492411;9458.196053335543;9474.95262523683;9567.043295670517;9593.568289426992;9756.902430975599;2868.5697145427935;2884.4086962172705;2884.4472641712237;2908.520094184436;2984.4031193761334;955.6989548292265;969.8302797010494;984.9803003939882;986.5166068626321;988.2884323287221;19538.413847584594;19797;19992.20031198736;20510;23732.762672373054;1015.4465816130227;1032.9070383665505;1039.298473530364;1067.770429357692;1077.7036315013434;11049.779004419866;11276.887231127748;11509.424528773528;11624.011958983412;13452.260125693181;477397;481239;484375;527432;533813;118760.40619796846;119477;121739;124018.37990809989;125119;1249.375312343828;1286.9935650321688;1318.604418674413;1319.399673148715;1333.3866421446244;19746.210151593776;21123.366299011053;21195.470113246676;21333.893330533247;21513;57176.42823571878;57775;58044.70977645085;59047.70476147592;60304;72946;73003.90494142698;73092.26907731067;73277.6336118316;73362;14448.27758612044;14705.779413308595;14800.111993280438;14877.776833347725;14906.925465372604;22692.546149076596;23355.88322058379;23482.295531134092;23516.647250290916;23625.29124126279;18027.729584056513;18681.719774203128;18838;19004.524886877938;19034.428967131007;15811.446599368966;16461.67076658484;16939.915300423912;17296.91351543234;17354.219060142575;18577.53556161107;19000.334988275343;19369.70945435848;19389.90305048522;20440.897795510926;14819;14823;14985.550433487013;15028.17345046033;15050.774238386213;17809;18779.90610046941;18956.0521973898;19062.428127156207;19075.141618627473 06:30:59 INFO - PID 14959 | |3;mootools.html;1355.1733442600016;1417.8369487508933;1424.6295963049604;1437.9496717614882;1440.6758479342143;13604.183748975056;14213.71572568548;14281.143131412122;14301.284935753196;14311.069780464275;11745.354005529693;12222.388880555958;13617.591472255823;14125.434982600684;14153.22157281349;2704.6078318643836;2733.221032005879;2755.600437936508;2757.1177223288555;2762.1989623009304;2550.132954795369;2670.612761149632;2751.7660998815027;2756.6691996960294;2762.599423083652;2638.9472210555873;2696.4202696420266;2721.809473336867;2738.137486691696;2740.1779466160174;2642.973570264292;2674.0774432820745;2695.0432596428377;2696.44722831819;2707.593860920858;2601.6877974642975;2604.7785938195275;2605.6612640356634;2614.6993095793846;2617.149426436416;13387.196768193842;13562.254076025814;13565;13567.932160339134;13618.046736728433;7606.201348858401;7911.9604401978195;7922.207779222089;7947.08608510023;7957.164497727771;5079.492050794928;5205.27126202332;5210.452902445227;5268.947310526923;5324.068288049576;1858.7955324914249;1897.250586018515;1900.9049547522568;1939.1177014458387;1962.4995626115249;22413.66379504309;22562;22658.09367625293;22674.093036278693;22819.543609127726;6293.244810622663;6478.805635830932;6494.805155845333;6636.502262330345;6687.398134167948;16151.273192706356;16162.111083890499;16164.595885102966;16187.514374568782;16197.59506012359;7291.015712878693;7544.660490277951;7546.1321947976685;7547.0943486781935;7547.207543207994;6456.870862582816;6920.100386949765;6939.097917270823;7201.747938822116;7212.675429605681;4954.256861470808;5063.974680126649;5100.897982040338;5139.254808052811;5161.122609156452;1290.2709968867748;1335.5459143891123;1458.2781523146111;1463.817022872141;1486.413640265951;882.6381183714647;883.2139395937621;899.5547204133865;916.6241840845355;932.4591736792644;7456.701731930771;7546.924530754732;7789.792582149776;7914.762557123296;8022.679092836222;952.5665822050951;994.4182653147844;1002.0931057393071;1007.3200589601989;1027.6660085472251;4353.455818022747;4527.615152712056;4979.05397974391;4991.750412479361;5031.647784655039;18739.531511712044;19376.903115484612;19505.317313893946;19583.412497625093;19705.211791528465;18862.81137188638;19366.4190074298;19512.414627561197;19515.90242048809;19628.70556941647;10869.184811139196;10878.673639790819;10885.292455990335;10986.340819550853;11013.83479247812;7695.807604809701;7725.961370193113;7895.328897043586;7927.841443170989;7973.401994850294;15413.922930385725;16332.673346532765;16436.83563164353;17254;17316.740248896025;15645.687086258438;17263.223154957806;17508.387206447715;17549.473515794547;17816.10919454048;10978.341299522055;11122.666320010412;11196.440177991231;11224.158188136085;11224.719382015188;12955.805662914876;13103.118270994559;13337.933310333774;13355.53255636048;13391.598252052065;9071.59177837012;9939;10782.08352290064;10950.123990080616;11097.833532497181;10058.899411006088;10642.680719578426;10688.091512221548;10782.029617334478;10958.890411096107;9649.324547281623;9768;9771.609135634495;9775.364601300893;9781.902180978384;6671.666416679243;7080.150381953992;7119.9644001781735;7167.390771784457;7283.890741638774;6801.387875091265;7007.754728584475;7034.155901291878;7187.460940429593;7209.531380460253 06:30:59 INFO - PID 14959 | |4;prototype.html;495.22744518551076;499.3957311652902;529.8251576979598;530.5649367518635;533.2081858440216;6272.968635156829;6315.242170939488;6331.52513561483;6332.706992363968;6361.618302901829;6000.799840031989;6092.725827337769;6137.416945390192;6167.907481387771;6199.140257922616;4914.189158788796;4945.604351651859;4947.688862451453;4953.529414705597;4984.32711583937;4805.90388192236;4955.529224723664;4957.5786058185095;4980.4272508661425;4991.825286114987;4953.727544985024;4955.4548999610015;4968.229924361712;4972.751362431882;4977.203647416414;4932.80268789248;4950.455449900508;4973.179425394806;4989.700617962933;4994.250862370655;4390.714603550759;4479.70881892676;4482.686211965164;4499.775011249457;4513.548645135493;6011.218541589609;6047.425494578008;6080.665563394055;6085.695715214221;6142.907856382158;5634.605577609569;5663.791121462633;5696.515796157331;5748.396418376052;5774.335951365605;6381.425671689523;6439.613623182624;6481.28705842357;6529.640869752162;6586.661735084072;4863.343448634424;4887.169181239163;4898.2652602109965;4918.360613120307;4947.381577302837;6858.348456896587;6903.206131294915;6929.272426395206;6937.445004399636;6961.408280296181;4975.402951645826;4999.825006124841;5022.874428139326;5030.647854650212;5055.620828437882;5100.260462232955;5108.259302401131;5123.692578445305;5129.666571672829;5149.609605406519;5620.57845661577;5629.634073785191;5687.459691329317;5720.227769251181;5767.798127065533;6402.423781859655;6425.228972523327;6455.870882582322;6523.18460192476;6577.14497115372;1687.64559442516;1724.3878423159597;1740.2169023939025;1740.7301868210448;1760.1815155952543;1217.075022982522;1217.7686239614445;1235.8331625230658;1245.3897590180745;1264.8861602455638;5646.124850648074;5705.115707065329;5744.339400968858;5753;5783.334916484658;6554.344565543408;6748.156480439945;6762.357576030269;6774.153230846145;6776.7628133015105;5784.681842498703;5791.131330300404;5797.130430435468;5805.970970145207;5820.854478638068;3572.91067723309;3599.1824128815306;3600.927981440409;3608.350496910529;3615.240799432096;6504.138179201136;6513.576617519846;6521.804345869631;6539.313372095957;6616.801495955129;6673.264951112746;6826;6904.689288982008;6922.169339679271;6979.197392299849;6469.805905822739;6508.787012415802;6525.2169739631545;6551.296662867784;6565.573237739627;6689.49828762835;6696.899546506904;6718.782801675337;6767.39093481589;6792.490563207681;6561.1470508833545;6581.835454113494;6669.7332106715185;6731.293214212633;6734.158230221223;6475.611463312216;6505.642189679613;6514.0880276760345;6544.934550654432;6555.508336874849;5029.371328583927;5029.748512574283;5042.546170844642;5043.470435604208;5063.316452278895;6463.515236357386;6696.83257918556;6776.170433982698;6780.186377634715;6820.590764554143;6006.489448396936;6365.96817015912;6388.105665206782;6482.805515834532;6487.513436492188;6433.420992110732;6462.676866156579;6483.805485835433;6510.511711621552;6528.771492997722;6317.96841015792;6391.840203994937;6398.776042838478;6462.450691691259;6497.18785151856;6474.838129046811;6503.837404064936;6510.804675859732;6527.738890444329;6575.243846957661;6258.311585725658;6283.3088360281245;6309.242890852944;6316.684165791784;6318.936810632019 06:30:59 INFO - PID 14959 | |5;yui.html;907.691384929124;915.569682249343;931.9254459643229;938.1462868789403;946.9479178645174;17690.734638980408;18709.719354209697;18741;18776.90611546944;18785;19922;21963.780362196372;21998.450038749;22046.33860984173;22145;1046.8429735539673;1050.4380156616212;1059.5391004912888;1060.5598676549223;1063.0538820449806;977.6529332087114;1044.69703785902;1055.5619417941584;1062.102523367757;1063.0379506546587;1115.3029356652091;1117.636768050383;1124.3029321820484;1124.4040658450992;1126.881677423871;1112.2992514715718;1114.309128340426;1116.112690411117;1119.5018216893486;1120.4117838135003;813.7640084375524;817.1624085312602;817.9672813087469;818.1818181818181;819.713100414856;17406.82593174065;17861.106944652845;19436;19681.803181968142;19721.40835774929;20722;20783.376498705064;21149.25977590777;21214;21378.358649240392;16246.431374901822;16606.169691515377;16739.497815065446;16748.078855663054;16750.246238919277;3534.3108093921696;3554.5556805399324;3555.4489054196642;3562.09166662502;3569.7322700797545;112706;113869;115558;126272;127941;16755.41356052532;16870.578235543962;16928.153592320334;16928.238229279465;17035.829641703673;29406.411871762444;31277.687223127934;31392.215194620316;31525;31536.684633153833;8561.529115898686;8750.956245218733;8830.470171789584;8835;8835.293176545989;4046.9392959105635;4111.6299533042165;4124.4019617155345;4129.2773764591075;4136.710430269913;4713.363695901078;4993.550580447704;5148.716820574904;6032.185654936615;6080.483158931452;1092.1317552545745;1118.4799068433217;1131.3551275772732;1138.612871623652;1142.948567314473;673.9797806065826;674.6120980436269;685.5749435350115;719.1873183302835;729.4055344893894;12332.19840710351;12460.190087644274;12464.81302780459;12489.625311240678;12816.80774788379;639.788869673016;671.4561205423622;677.0656494038195;694.0318256032806;696.905917701114;5238.685678859204;5475.315585551806;5723.456271654186;6098.26820781509;6231.937680623136;99822;106007.46996264969;111473.44263278793;111911.44044279726;113687;94025.52987235157;95451;95628.52185739166;96174.51912740532;98105.50947245218;79939.60030199928;79966.60016699879;80986.59506702429;84928.57535712281;91228.08771912196;12157.69605759863;12943.352832358532;13002.739945201232;13050.4127314273;13507.527236546674;36315.27369452649;37397.6260237405;38339;38607.80696096501;40639.39040914329;45601.77199114116;47333;48112.75943620259;49068.75465622792;50487.49512504975;18619.162137703566;18847.15187816524;19078.23687052558;19270.61458770845;19399.612007760046;20992.475188120417;21359.03884325178;21470.463238419165;21549.707017578996;21599.568008640053;18182.181801818686;18203.908980455013;18238.635227295115;18642.254309827997;18722.25110995545;17362.305507779547;17863.910680447036;17930;18255;18630.53423664419;17638.647227055644;17907.73138402951;17921.820781792536;18128.81871181324;18169.27322907122;12700.237985720887;12846.357682116044;13037.934810326267;13441.260730659907;13662.521811736542;13017.153884997444;13220.537281195113;13255.469781208643;13434.126781759154;13899.16605003703 06:30:59 INFO - PID 14959 | __end_tp_report 06:30:59 INFO - PID 14959 | __start_cc_report 06:30:59 INFO - PID 14959 | _x_x_mozilla_cycle_collect,381 06:30:59 INFO - PID 14959 | __end_cc_report 06:30:59 INFO - PID 14959 | __startTimestamp1500989459809__endTimestamp 06:30:59 INFO - PID 14959 | 06:30:59 INFO - PID 14959 | ------- Summary: start ------- 06:30:59 INFO - PID 14959 | Number of tests: 6 06:30:59 INFO - PID 14959 | 06:30:59 INFO - PID 14959 | [#0] dojo.html Cycles:165 Average:6110.54 Median:6326.97 stddev:717.85 (11.3%) stddev-sans-first:680.98 06:30:59 INFO - PID 14959 | Values: 3132.7 3138.7 3170.6 3174.9 3196.9 6192.2 6192.7 6269.6 6276.4 6292.2 6059.2 6181.6 6195.5 6199.5 6209.6 5546.3 5591.6 5595.8 5596.6 5620.9 5604.2 5649.5 5741.9 5752.1 5773.9 5701.9 5754.6 5761.6 5767.5 5837.1 5560.1 5647.2 5738.9 5739.4 5791.6 5360.9 5588.1 5654.1 5700.5 5726.9 6020.2 6093.4 6176.4 6179.4 6193.5 6462.8 6542.2 6561.0 6571.4 6585.6 6631.7 6632.5 6632.9 6644.2 6694.8 6188.8 6201.1 6205.4 6211.5 6218.0 6768.6 6784.6 6844.0 6870.9 6955.0 6455.9 6462.7 6471.6 6547.1 6561.7 6496.2 6611.0 6617.6 6632.0 6643.7 6535.3 6579.1 6606.0 6619.6 6632.2 6501.1 6556.1 6566.6 6660.2 6681.2 5244.0 5282.7 5327.8 5364.4 5370.1 4588.7 4605.6 4607.0 4632.4 4637.7 5637.6 5722.1 5795.2 5800.1 5800.7 6441.3 6497.9 6647.0 6702.9 6720.7 5665.6 5709.1 5788.5 5792.5 5793.4 5812.7 5847.3 5875.1 5889.1 5915.4 6418.5 6431.6 6470.3 6523.4 6557.9 6597.3 6653.8 6676.0 6678.4 6740.5 6490.3 6505.2 6560.8 6567.1 6573.1 6480.4 6510.6 6538.5 6637.4 6652.4 6671.9 6714.1 6742.5 6758.0 6762.5 6301.0 6410.5 6433.0 6541.6 6553.1 6469.9 6500.2 6512.0 6512.0 6533.8 6229.1 6246.2 6303.9 6324.0 6398.0 6506.8 6534.7 6577.8 6584.0 6620.8 6290.8 6308.3 6327.0 6391.7 6409.8 06:30:59 INFO - PID 14959 | 06:30:59 INFO - PID 14959 | [#1] ext.html Cycles:180 Average:37883.33 Median:3535.42 stddev:54852.17 (1551.5%) stddev-sans-first:54935.35 06:30:59 INFO - PID 14959 | Values: 794.6 849.3 878.4 882.2 1171.8 31484.5 31983.5 41741.4 43061.4 43066.8 42930.8 43298.0 43310.1 43399.0 43442.6 7581.8 7591.8 7806.5 7808.3 7818.5 7668.2 7768.3 7772.0 7781.2 7784.1 7758.9 7809.5 7813.1 7814.2 7816.9 7720.3 7726.5 7761.5 7778.1 7778.9 7611.8 7647.1 7658.4 7680.5 7697.0 38767.6 38877.2 38916.4 39090.2 39111.6 3494.0 3495.1 3504.6 3532.1 3538.8 31838.0 31975.8 31978.8 32077.4 32152.0 4852.6 4893.0 4901.7 4920.1 4933.0 185892.0 186680.0 187787.1 188491.0 188742.0 50269.7 50284.5 50389.2 50497.2 50632.2 52024.5 52273.2 52837.5 52844.2 52968.2 13595.4 14051.9 14205.6 14223.0 14249.4 10972.3 12671.7 12871.9 12981.3 12996.8 14414.4 14571.7 14644.4 14668.0 14853.2 5928.9 6019.4 6071.6 6091.9 6104.5 949.8 976.0 989.2 989.6 1009.3 22981.7 23346.5 23359.9 23435.8 23637.2 943.2 956.4 956.6 976.0 1103.4 11558.5 11954.8 11968.6 11975.0 12073.1 235800.0 237319.0 237952.0 238094.0 238127.0 52983.2 53823.0 53907.0 54016.0 54039.0 1388.6 1448.3 1457.1 1460.2 1475.1 20465.4 21300.0 21940.8 22001.8 22086.4 33194.7 35250.8 37678.8 37717.8 37761.6 204134.0 204415.0 206102.0 206965.0 207588.0 30854.0 31680.5 31715.5 31854.0 35079.8 44366.3 44379.8 44404.1 44668.6 44872.0 31976.7 31988.2 33080.0 33102.5 33173.7 30380.2 32217.7 32253.5 32385.5 32914.7 35525.0 35626.1 35844.3 36109.6 36165.8 29716.7 30966.7 31663.8 31961.5 32544.0 21488.7 23535.3 23543.4 23615.8 23916.0 06:30:59 INFO - PID 14959 | 06:30:59 INFO - PID 14959 | [#2] jquery.html Cycles:180 Average:35644.56 Median:23499.47 stddev:84537.62 (359.7%) stddev-sans-first:84733.75 06:30:59 INFO - PID 14959 | Values: 570.7 575.2 585.0 598.2 602.7 21951.8 22336.3 23224.2 23227.9 23284.0 25604.2 26305.7 26351.7 26369.2 26574.9 6502.0 6576.3 6656.4 6664.0 6677.8 5973.8 6556.5 6591.7 6628.3 6633.8 6498.9 6516.9 6532.1 6546.3 6554.8 6538.6 6544.8 6550.1 6553.6 6555.4 6091.7 6108.5 6110.2 6118.8 6131.3 28755.4 29198.1 29668.5 29716.6 30210.1 1867.8 1922.0 1922.3 1924.0 1929.3 19177.3 19799.4 19841.3 19858.2 19858.7 2363.0 2395.4 2437.3 2448.8 2466.5 137158.0 138530.0 139448.0 140066.0 140953.0 14231.4 15217.8 15266.2 15340.7 15865.3 22769.5 23769.9 24231.3 24242.9 24265.2 9869.1 9879.2 10124.3 10247.4 10336.8 9123.4 9170.2 9191.8 9254.3 9303.4 9458.2 9475.0 9567.0 9593.6 9756.9 2868.6 2884.4 2884.4 2908.5 2984.4 955.7 969.8 985.0 986.5 988.3 19538.4 19797.0 19992.2 20510.0 23732.8 1015.4 1032.9 1039.3 1067.8 1077.7 11049.8 11276.9 11509.4 11624.0 13452.3 477397.0 481239.0 484375.0 527432.0 533813.0 118760.4 119477.0 121739.0 124018.4 125119.0 1249.4 1287.0 1318.6 1319.4 1333.4 19746.2 21123.4 21195.5 21333.9 21513.0 57176.4 57775.0 58044.7 59047.7 60304.0 72946.0 73003.9 73092.3 73277.6 73362.0 14448.3 14705.8 14800.1 14877.8 14906.9 22692.5 23355.9 23482.3 23516.6 23625.3 18027.7 18681.7 18838.0 19004.5 19034.4 15811.4 16461.7 16939.9 17296.9 17354.2 18577.5 19000.3 19369.7 19389.9 20440.9 14819.0 14823.0 14985.6 15028.2 15050.8 17809.0 18779.9 18956.1 19062.4 19075.1 06:30:59 INFO - PID 14959 | 06:30:59 INFO - PID 14959 | [#3] mootools.html Cycles:180 Average:8662.53 Median:2615.92 stddev:5879.02 (224.7%) stddev-sans-first:5869.87 06:30:59 INFO - PID 14959 | Values: 1355.2 1417.8 1424.6 1437.9 1440.7 13604.2 14213.7 14281.1 14301.3 14311.1 11745.4 12222.4 13617.6 14125.4 14153.2 2704.6 2733.2 2755.6 2757.1 2762.2 2550.1 2670.6 2751.8 2756.7 2762.6 2638.9 2696.4 2721.8 2738.1 2740.2 2643.0 2674.1 2695.0 2696.4 2707.6 2601.7 2604.8 2605.7 2614.7 2617.1 13387.2 13562.3 13565.0 13567.9 13618.0 7606.2 7912.0 7922.2 7947.1 7957.2 5079.5 5205.3 5210.5 5268.9 5324.1 1858.8 1897.3 1900.9 1939.1 1962.5 22413.7 22562.0 22658.1 22674.1 22819.5 6293.2 6478.8 6494.8 6636.5 6687.4 16151.3 16162.1 16164.6 16187.5 16197.6 7291.0 7544.7 7546.1 7547.1 7547.2 6456.9 6920.1 6939.1 7201.7 7212.7 4954.3 5064.0 5100.9 5139.3 5161.1 1290.3 1335.5 1458.3 1463.8 1486.4 882.6 883.2 899.6 916.6 932.5 7456.7 7546.9 7789.8 7914.8 8022.7 952.6 994.4 1002.1 1007.3 1027.7 4353.5 4527.6 4979.1 4991.8 5031.6 18739.5 19376.9 19505.3 19583.4 19705.2 18862.8 19366.4 19512.4 19515.9 19628.7 10869.2 10878.7 10885.3 10986.3 11013.8 7695.8 7726.0 7895.3 7927.8 7973.4 15413.9 16332.7 16436.8 17254.0 17316.7 15645.7 17263.2 17508.4 17549.5 17816.1 10978.3 11122.7 11196.4 11224.2 11224.7 12955.8 13103.1 13337.9 13355.5 13391.6 9071.6 9939.0 10782.1 10950.1 11097.8 10058.9 10642.7 10688.1 10782.0 10958.9 9649.3 9768.0 9771.6 9775.4 9781.9 6671.7 7080.2 7120.0 7167.4 7283.9 6801.4 7007.8 7034.2 7187.5 7209.5 06:30:59 INFO - PID 14959 | 06:30:59 INFO - PID 14959 | [#4] prototype.html Cycles:180 Average:5502.59 Median:6089.21 stddev:1538.06 (25.3%) stddev-sans-first:1495.75 06:30:59 INFO - PID 14959 | Values: 495.2 499.4 529.8 530.6 533.2 6273.0 6315.2 6331.5 6332.7 6361.6 6000.8 6092.7 6137.4 6167.9 6199.1 4914.2 4945.6 4947.7 4953.5 4984.3 4805.9 4955.5 4957.6 4980.4 4991.8 4953.7 4955.5 4968.2 4972.8 4977.2 4932.8 4950.5 4973.2 4989.7 4994.3 4390.7 4479.7 4482.7 4499.8 4513.5 6011.2 6047.4 6080.7 6085.7 6142.9 5634.6 5663.8 5696.5 5748.4 5774.3 6381.4 6439.6 6481.3 6529.6 6586.7 4863.3 4887.2 4898.3 4918.4 4947.4 6858.3 6903.2 6929.3 6937.4 6961.4 4975.4 4999.8 5022.9 5030.6 5055.6 5100.3 5108.3 5123.7 5129.7 5149.6 5620.6 5629.6 5687.5 5720.2 5767.8 6402.4 6425.2 6455.9 6523.2 6577.1 1687.6 1724.4 1740.2 1740.7 1760.2 1217.1 1217.8 1235.8 1245.4 1264.9 5646.1 5705.1 5744.3 5753.0 5783.3 6554.3 6748.2 6762.4 6774.2 6776.8 5784.7 5791.1 5797.1 5806.0 5820.9 3572.9 3599.2 3600.9 3608.4 3615.2 6504.1 6513.6 6521.8 6539.3 6616.8 6673.3 6826.0 6904.7 6922.2 6979.2 6469.8 6508.8 6525.2 6551.3 6565.6 6689.5 6696.9 6718.8 6767.4 6792.5 6561.1 6581.8 6669.7 6731.3 6734.2 6475.6 6505.6 6514.1 6544.9 6555.5 5029.4 5029.7 5042.5 5043.5 5063.3 6463.5 6696.8 6776.2 6780.2 6820.6 6006.5 6366.0 6388.1 6482.8 6487.5 6433.4 6462.7 6483.8 6510.5 6528.8 6318.0 6391.8 6398.8 6462.5 6497.2 6474.8 6503.8 6510.8 6527.7 6575.2 6258.3 6283.3 6309.2 6316.7 6318.9 06:30:59 INFO - PID 14959 | 06:30:59 INFO - PID 14959 | [#5] yui.html Cycles:180 Average:22805.27 Median:19558.90 stddev:30410.69 (155.5%) stddev-sans-first:30451.55 06:30:59 INFO - PID 14959 | Values: 907.7 915.6 931.9 938.1 946.9 17690.7 18709.7 18741.0 18776.9 18785.0 19922.0 21963.8 21998.5 22046.3 22145.0 1046.8 1050.4 1059.5 1060.6 1063.1 977.7 1044.7 1055.6 1062.1 1063.0 1115.3 1117.6 1124.3 1124.4 1126.9 1112.3 1114.3 1116.1 1119.5 1120.4 813.8 817.2 818.0 818.2 819.7 17406.8 17861.1 19436.0 19681.8 19721.4 20722.0 20783.4 21149.3 21214.0 21378.4 16246.4 16606.2 16739.5 16748.1 16750.2 3534.3 3554.6 3555.4 3562.1 3569.7 112706.0 113869.0 115558.0 126272.0 127941.0 16755.4 16870.6 16928.2 16928.2 17035.8 29406.4 31277.7 31392.2 31525.0 31536.7 8561.5 8751.0 8830.5 8835.0 8835.3 4046.9 4111.6 4124.4 4129.3 4136.7 4713.4 4993.6 5148.7 6032.2 6080.5 1092.1 1118.5 1131.4 1138.6 1142.9 674.0 674.6 685.6 719.2 729.4 12332.2 12460.2 12464.8 12489.6 12816.8 639.8 671.5 677.1 694.0 696.9 5238.7 5475.3 5723.5 6098.3 6231.9 99822.0 106007.5 111473.4 111911.4 113687.0 94025.5 95451.0 95628.5 96174.5 98105.5 79939.6 79966.6 80986.6 84928.6 91228.1 12157.7 12943.4 13002.7 13050.4 13507.5 36315.3 37397.6 38339.0 38607.8 40639.4 45601.8 47333.0 48112.8 49068.8 50487.5 18619.2 18847.2 19078.2 19270.6 19399.6 20992.5 21359.0 21470.5 21549.7 21599.6 18182.2 18203.9 18238.6 18642.3 18722.3 17362.3 17863.9 17930.0 18255.0 18630.5 17638.6 17907.7 17921.8 18128.8 18169.3 12700.2 12846.4 13037.9 13441.3 13662.5 13017.2 13220.5 13255.5 13434.1 13899.2 06:30:59 INFO - PID 14959 | -------- Summary: end -------- 06:30:59 INFO - PID 14959 | 06:31:00 INFO - TEST-INFO | 14959: exit 0 06:31:00 INFO - TEST-OK | dromaeo_css | took 1113683ms 06:31:00 INFO - TEST-START | kraken 06:31:00 INFO - Initialising browser for kraken test... 06:31:00 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36213/getInfo.html -profile /tmp/tmpNOXt7J/profile 06:31:00 INFO - TEST-INFO | started process 15341 (/builds/slave/test/build/application/firefox/firefox http://localhost:36213/getInfo.html) 06:31:06 INFO - TEST-INFO | 15341: exit 0 06:31:06 INFO - Browser initialized. 06:31:06 INFO - Running cycle 1/1 for kraken test... 06:31:06 INFO - TEST-INFO | started process 15571 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNOXt7J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:31:07 INFO - PID 15571 | 06:31:07 INFO - PID 15571 | (/builds/slave/test/build/application/firefox/firefox:15626): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:31:07 INFO - PID 15571 | 06:31:17 INFO - PID 15571 | RSS: Main: 173498368 06:31:17 INFO - PID 15571 | 06:31:20 INFO - PID 15571 | Cycle 1(1): loaded http://localhost:36213/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36213/tests/kraken/driver.html?testName=audio-beat-detection) 06:31:21 INFO - PID 15571 | RSS: Main: 180060160 06:31:21 INFO - PID 15571 | 06:31:23 INFO - PID 15571 | Cycle 1(1): loaded http://localhost:36213/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36213/tests/kraken/driver.html?testName=audio-dft) 06:31:24 INFO - PID 15571 | RSS: Main: 179630080 06:31:24 INFO - PID 15571 | 06:31:27 INFO - PID 15571 | Cycle 1(1): loaded http://localhost:36213/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36213/tests/kraken/driver.html?testName=audio-fft) 06:31:28 INFO - PID 15571 | RSS: Main: 173948928 06:31:28 INFO - PID 15571 | 06:31:30 INFO - PID 15571 | Cycle 1(1): loaded http://localhost:36213/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36213/tests/kraken/driver.html?testName=audio-oscillator) 06:31:30 INFO - PID 15571 | RSS: Main: 174882816 06:31:30 INFO - PID 15571 | 06:31:33 INFO - PID 15571 | Cycle 1(1): loaded http://localhost:36213/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36213/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:31:33 INFO - PID 15571 | RSS: Main: 174268416 06:31:33 INFO - PID 15571 | 06:31:36 INFO - PID 15571 | Cycle 1(1): loaded http://localhost:36213/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36213/tests/kraken/driver.html?testName=imaging-darkroom) 06:31:37 INFO - PID 15571 | RSS: Main: 177254400 06:31:37 INFO - PID 15571 | 06:31:41 INFO - PID 15571 | Cycle 1(1): loaded http://localhost:36213/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36213/tests/kraken/driver.html?testName=imaging-desaturate) 06:31:41 INFO - PID 15571 | RSS: Main: 177266688 06:31:41 INFO - PID 15571 | 06:31:44 INFO - PID 15571 | Cycle 1(1): loaded http://localhost:36213/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36213/tests/kraken/driver.html?testName=json-parse-financial) 06:31:45 INFO - PID 15571 | RSS: Main: 178135040 06:31:45 INFO - PID 15571 | 06:31:46 INFO - PID 15571 | Cycle 1(1): loaded http://localhost:36213/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36213/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:31:47 INFO - PID 15571 | RSS: Main: 178405376 06:31:47 INFO - PID 15571 | 06:31:49 INFO - PID 15571 | Cycle 1(1): loaded http://localhost:36213/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36213/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:31:49 INFO - PID 15571 | RSS: Main: 175714304 06:31:49 INFO - PID 15571 | 06:31:51 INFO - PID 15571 | Cycle 1(1): loaded http://localhost:36213/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36213/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:31:52 INFO - PID 15571 | RSS: Main: 175243264 06:31:52 INFO - PID 15571 | 06:31:55 INFO - PID 15571 | Cycle 1(1): loaded http://localhost:36213/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36213/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:31:56 INFO - PID 15571 | RSS: Main: 175882240 06:31:56 INFO - PID 15571 | 06:31:59 INFO - PID 15571 | Cycle 1(1): loaded http://localhost:36213/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36213/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:31:59 INFO - PID 15571 | RSS: Main: 175575040 06:31:59 INFO - PID 15571 | 06:32:01 INFO - PID 15571 | Cycle 1(1): loaded http://localhost:36213/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36213/tests/kraken/driver.html?testName=ai-astar) 06:32:01 INFO - PID 15571 | RSS: Main: 177078272 06:32:01 INFO - PID 15571 | 06:32:01 INFO - PID 15571 | __start_tp_report 06:32:01 INFO - PID 15571 | _x_x_mozilla_page_load 06:32:01 INFO - PID 15571 | _x_x_mozilla_page_load_details 06:32:01 INFO - PID 15571 | |i|pagename|runs| 06:32:01 INFO - PID 15571 | |0;ai-astar;99;109;102;108;110;116;109;100;111;112 06:32:01 INFO - PID 15571 | |1;audio-beat-detection;149;118;143;174;123;143;152;119;176;119 06:32:01 INFO - PID 15571 | |2;audio-dft;164;161;163;163;163;162;163;169;169;162 06:32:01 INFO - PID 15571 | |3;audio-fft;75;75;76;172;77;77;73;76;155;77 06:32:01 INFO - PID 15571 | |4;audio-oscillator;81;82;137;81;81;81;138;81;82;135 06:32:01 INFO - PID 15571 | |5;imaging-gaussian-blur;114;114;114;114;115;114;115;114;114;113 06:32:01 INFO - PID 15571 | |6;imaging-darkroom;151;151;150;150;152;150;151;150;150;151 06:32:01 INFO - PID 15571 | |7;imaging-desaturate;94;94;96;99;93;94;94;95;95;95 06:32:01 INFO - PID 15571 | |8;json-parse-financial;55;55;56;70;55;55;56;55;54;56 06:32:01 INFO - PID 15571 | |9;json-stringify-tinderbox;55;54;54;54;54;53;60;54;54;54 06:32:01 INFO - PID 15571 | |10;stanford-crypto-aes;77;76;78;79;78;77;79;86;79;86 06:32:01 INFO - PID 15571 | |11;stanford-crypto-ccm;127;141;145;125;127;147;127;139;126;170 06:32:01 INFO - PID 15571 | |12;stanford-crypto-pbkdf2;177;193;172;176;182;194;174;180;177;172 06:32:01 INFO - PID 15571 | |13;stanford-crypto-sha256-iterative;68;81;66;75;70;68;70;66;70;68 06:32:01 INFO - PID 15571 | __end_tp_report 06:32:01 INFO - PID 15571 | __start_cc_report 06:32:01 INFO - PID 15571 | _x_x_mozilla_cycle_collect,945 06:32:01 INFO - PID 15571 | __end_cc_report 06:32:01 INFO - PID 15571 | __startTimestamp1500989521847__endTimestamp 06:32:01 INFO - PID 15571 | 06:32:01 INFO - PID 15571 | ------- Summary: start ------- 06:32:01 INFO - PID 15571 | Number of tests: 14 06:32:01 INFO - PID 15571 | 06:32:01 INFO - PID 15571 | [#0] ai-astar Cycles:10 Average:107.60 Median:110.50 stddev:5.52 (5.0%) stddev-sans-first:4.90 06:32:01 INFO - PID 15571 | Values: 99.0 109.0 102.0 108.0 110.0 116.0 109.0 100.0 111.0 112.0 06:32:01 INFO - PID 15571 | 06:32:01 INFO - PID 15571 | [#1] audio-beat-detection Cycles:10 Average:141.60 Median:146.00 stddev:21.92 (15.0%) stddev-sans-first:23.09 06:32:01 INFO - PID 15571 | Values: 149.0 118.0 143.0 174.0 123.0 143.0 152.0 119.0 176.0 119.0 06:32:01 INFO - PID 15571 | 06:32:01 INFO - PID 15571 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.00 stddev:2.81 (1.7%) stddev-sans-first:2.98 06:32:01 INFO - PID 15571 | Values: 164.0 161.0 163.0 163.0 163.0 162.0 163.0 169.0 169.0 162.0 06:32:01 INFO - PID 15571 | 06:32:01 INFO - PID 15571 | [#3] audio-fft Cycles:10 Average:93.30 Median:76.00 stddev:37.24 (49.0%) stddev-sans-first:38.90 06:32:01 INFO - PID 15571 | Values: 75.0 75.0 76.0 172.0 77.0 77.0 73.0 76.0 155.0 77.0 06:32:01 INFO - PID 15571 | 06:32:01 INFO - PID 15571 | [#4] audio-oscillator Cycles:10 Average:97.90 Median:81.00 stddev:26.76 (33.0%) stddev-sans-first:27.68 06:32:01 INFO - PID 15571 | Values: 81.0 82.0 137.0 81.0 81.0 81.0 138.0 81.0 82.0 135.0 06:32:01 INFO - PID 15571 | 06:32:01 INFO - PID 15571 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 06:32:01 INFO - PID 15571 | Values: 114.0 114.0 114.0 114.0 115.0 114.0 115.0 114.0 114.0 113.0 06:32:01 INFO - PID 15571 | 06:32:01 INFO - PID 15571 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:151.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 06:32:01 INFO - PID 15571 | Values: 151.0 151.0 150.0 150.0 152.0 150.0 151.0 150.0 150.0 151.0 06:32:01 INFO - PID 15571 | 06:32:01 INFO - PID 15571 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:1.66 (1.8%) stddev-sans-first:1.73 06:32:01 INFO - PID 15571 | Values: 94.0 94.0 96.0 99.0 93.0 94.0 94.0 95.0 95.0 95.0 06:32:01 INFO - PID 15571 | 06:32:01 INFO - PID 15571 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:55.50 stddev:4.72 (8.5%) stddev-sans-first:4.96 06:32:01 INFO - PID 15571 | Values: 55.0 55.0 56.0 70.0 55.0 55.0 56.0 55.0 54.0 56.0 06:32:01 INFO - PID 15571 | 06:32:01 INFO - PID 15571 | [#9] json-stringify-tinderbox Cycles:10 Average:54.60 Median:54.00 stddev:1.96 (3.6%) stddev-sans-first:2.07 06:32:01 INFO - PID 15571 | Values: 55.0 54.0 54.0 54.0 54.0 53.0 60.0 54.0 54.0 54.0 06:32:01 INFO - PID 15571 | 06:32:01 INFO - PID 15571 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:79.00 stddev:3.57 (4.5%) stddev-sans-first:3.67 06:32:01 INFO - PID 15571 | Values: 77.0 76.0 78.0 79.0 78.0 77.0 79.0 86.0 79.0 86.0 06:32:01 INFO - PID 15571 | 06:32:01 INFO - PID 15571 | [#11] stanford-crypto-ccm Cycles:10 Average:137.40 Median:140.00 stddev:14.28 (10.2%) stddev-sans-first:14.65 06:32:01 INFO - PID 15571 | Values: 127.0 141.0 145.0 125.0 127.0 147.0 127.0 139.0 126.0 170.0 06:32:01 INFO - PID 15571 | 06:32:01 INFO - PID 15571 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.70 Median:178.50 stddev:7.93 (4.4%) stddev-sans-first:8.35 06:32:01 INFO - PID 15571 | Values: 177.0 193.0 172.0 176.0 182.0 194.0 174.0 180.0 177.0 172.0 06:32:01 INFO - PID 15571 | 06:32:01 INFO - PID 15571 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.00 stddev:4.59 (6.6%) stddev-sans-first:4.80 06:32:01 INFO - PID 15571 | Values: 68.0 81.0 66.0 75.0 70.0 68.0 70.0 66.0 70.0 68.0 06:32:01 INFO - PID 15571 | -------- Summary: end -------- 06:32:01 INFO - PID 15571 | 06:32:02 INFO - PID 15571 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 06:32:02 INFO - TEST-INFO | 15571: exit 0 06:32:02 INFO - TEST-OK | kraken | took 62066ms 06:32:02 INFO - SUITE-END | took 1175s 06:32:03 INFO - Completed test suite (00:19:36) 06:32:03 INFO - javascript benchmark 06:32:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8478.4793945307, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3132.671069537697, 3138.701823326784, 3170.5719727836736, 3174.8730050797976, 3196.8561414736337, 6192.164057852188, 6192.659403732793, 6269.592476489025, 6276.372362763721, 6292.18201633787, 6059.242594675666, 6181.567290289681, 6195.535334849893, 6199.473044791198, 6209.627422354662, 5546.334439867202, 5591.6365436246515, 5595.804146854841, 5596.608237423382, 5620.887582248352, 5604.243427137325, 5649.49154576088, 5741.913871291934, 5752.079667253241, 5773.855653608673, 5701.8574535636735, 5754.597178197528, 5761.625494342854, 5767.480926716595, 5837.124431335291, 5560.054790685553, 5647.209390685307, 5738.913916291259, 5739.3973632768375, 5791.565632577553, 5360.91958620621, 5588.133839254922, 5654.123610840326, 5700.515456186229, 5726.856828579319, 6020.247469066367, 6093.421124993119, 6176.3514830943, 6179.443850053517, 6193.473554747852, 6462.773802916875, 6542.214934207878, 6561.0, 6571.408573228385, 6585.637789921552, 6631.7347306107695, 6632.502562307846, 6632.9336706633285, 6644.235912870034, 6694.799156025327, 6188.84527886802, 6201.10084037812, 6205.410486003822, 6211.503079753609, 6217.96891015542, 6768.593884366954, 6784.59292442455, 6843.965780171166, 6870.931290687129, 6954.965225173943, 6455.870882582322, 6462.741490340428, 6471.644059576674, 6547.083408322838, 6561.671916404161, 6496.187976502937, 6610.96694516534, 6617.60294382329, 6631.966840165768, 6643.667816609151, 6535.3464653534265, 6579.111819904251, 6606.042123892009, 6619.635920024445, 6632.2372927114, 6501.0573466847045, 6556.147700798866, 6566.606003639797, 6660.167479065117, 6681.164854393201, 5244.0, 5282.683039017671, 5327.786888524493, 5364.356277246756, 5370.087085195526, 4588.678792484494, 4605.585497305258, 4606.976965115153, 4632.420947381577, 4637.721736695809, 5637.605367624309, 5722.084466485342, 5795.188673585617, 5800.071988481823, 5800.709964501758, 6441.259255185713, 6497.8700425992165, 6647.0, 6702.899456508157, 6720.731170753213, 5665.6034077614995, 5709.115087161496, 5788.450097240755, 5792.478676919098, 5793.420657934257, 5812.709364531756, 5847.26909136358, 5875.059990401515, 5889.0871914852405, 5915.40845915405, 6418.4544313731985, 6431.646259455775, 6470.2559205691, 6523.445507131947, 6557.9344206557325, 6597.340265973365, 6653.833654158685, 6676.0, 6678.3989440950545, 6740.460763138839, 6490.286068532552, 6505.186851643544, 6560.8359791005605, 6567.080608714688, 6573.1454910861285, 6480.44916182111, 6510.641914694548, 6538.509611779041, 6637.402633762985, 6652.368025037614, 6671.8665626686225, 6714.093597364294, 6742.494312926452, 6757.966210168917, 6762.52662313653, 6300.9684951574945, 6410.45511131559, 6432.9678351607945, 6541.574797638138, 6553.115329430466, 6469.870602587827, 6500.154979852589, 6511.967440162769, 6512.0, 6533.836654083496, 6229.0967809668255, 6246.156768836331, 6303.905441418291, 6323.9683801580695, 6398.0083087121575, 6506.837329066622, 6534.705938232886, 6577.769778057745, 6583.967080164569, 6620.8344791380605, 6290.811275661737, 6308.306086330592, 6326.9683651581445, 6391.6804159792755, 6409.775657852139], "value": 6057.16105578672, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [794.5629903553048, 849.2993280543552, 878.4246318661275, 882.1972005475019, 1171.7832201042802, 31484.527732084036, 31983.52024719631, 41741.373879391795, 43061.35407968883, 43066.78466607662, 42930.78534607323, 43298.0, 43310.13379732404, 43399.0, 43442.56557434425, 7581.77254682359, 7591.81020474487, 7806.5316081035035, 7808.258215469521, 7818.45270831042, 7668.194839541851, 7768.300852923236, 7772.028496437945, 7781.182975787546, 7784.1437441881635, 7758.883616745725, 7809.453338266324, 7813.062432508107, 7814.179511151333, 7816.921830781676, 7720.3051725344985, 7726.459147859652, 7761.495502792301, 7778.144404115543, 7778.8833167502535, 7611.771646850603, 7647.120581133186, 7658.425618078611, 7680.462367634268, 7697.0378702662165, 38767.61232387668, 38877.22245555073, 38916.416253756215, 39090.21819563593, 39111.60888391108, 3494.0391392367046, 3495.0912762681633, 3504.56192975878, 3532.0816587687127, 3538.752287339887, 31838.0, 31975.840120799247, 31978.84010579932, 32077.358452831046, 32152.0, 4852.636052296092, 4893.04585605807, 4901.730404827733, 4920.0651876143775, 4933.038057578774, 185892.0, 186680.0, 187787.12212877834, 188491.0, 188741.99999999863, 50269.74865125724, 50284.49715502798, 50389.24416133761, 50497.242541361906, 50632.24051639228, 52024.479755201966, 52273.215901761505, 52837.47162528326, 52844.20733688998, 52968.20547691788, 13595.388207530486, 14051.929740351234, 14205.644858878612, 14223.0, 14249.430022799179, 10972.341659500455, 12671.683207919692, 12871.935640321739, 12981.286029268482, 12996.805047924288, 14414.351354189086, 14571.708565828623, 14644.414223431157, 14668.0, 14853.183074930766, 5928.851778705567, 6019.428154325332, 6071.635701857903, 6091.878162436727, 6104.542159337979, 949.8432758594754, 975.9804803903883, 989.2333441582687, 989.6486747204783, 1009.2632378363835, 22981.655275170884, 23346.53306933852, 23359.88320058389, 23435.7656423437, 23637.172698955455, 943.1794338925179, 956.4183170393485, 956.5599824080862, 976.0142256321167, 1103.365564800227, 11558.479868405942, 11954.772211502846, 11968.640940771791, 11975.0, 12073.094517911191, 235800.0, 237319.0, 237952.0, 238094.0, 238127.0, 52983.20525192125, 53823.0, 53907.0, 54016.0, 54039.0, 1388.55566218809, 1448.3482432905025, 1457.0820383158543, 1460.1750011243614, 1475.1223022301713, 20465.38603841887, 21300.0, 21940.780592193874, 22001.779982200613, 22086.447838804157, 33194.66805331916, 35250.823745881105, 37678.811605941795, 37717.81141094277, 37761.62238377581, 204134.0, 204415.0, 206102.0, 206965.0, 207588.0, 30854.0, 31680.524792127675, 31715.524267135548, 31854.044378668677, 35079.82460087683, 44366.3345049831, 44379.77810110929, 44404.11191776211, 44668.55331446644, 44872.0, 31976.68023319737, 31988.20029499281, 33080.0, 33102.5034624476, 33173.66826331706, 30380.24049398783, 32217.680122637168, 32253.51619725753, 32385.51421728723, 32914.67085329116, 35525.0, 35626.10934726652, 35844.28311433704, 36109.63890361063, 36165.819170903975, 29716.702832971394, 30966.690333097282, 31663.84168079237, 31961.520577190895, 32544.0, 21488.677669835277, 23535.293941181793, 23543.41141471477, 23615.763842361357, 23916.0], "value": 17051.07539509001, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.7460180219799, 575.1746244139663, 584.9532037437003, 598.2462097756825, 602.7016626769748, 21951.780482195172, 22336.329910102682, 23224.187153449613, 23227.883860580696, 23284.0, 25604.23187304379, 26305.736942630567, 26351.73648263517, 26369.208923732273, 26574.867125664394, 6502.0, 6576.309487503815, 6656.434203092743, 6664.0, 6677.8330541736605, 5973.761049558012, 6556.475481961455, 6591.7363305467725, 6628.270890202074, 6633.834154146137, 6498.9025164622335, 6516.93483065168, 6532.052852336408, 6546.279909209983, 6554.7705830295945, 6538.640374779409, 6544.836379090513, 6550.0829883816305, 6553.574017688835, 6555.44278736308, 6091.695415229221, 6108.480779133779, 6110.175126357929, 6118.755249790003, 6131.325554189036, 28755.424891502054, 29198.124056278346, 29668.531984718513, 29716.55425168624, 30210.09369718912, 1867.82255685711, 1922.0, 1922.2695375757123, 1924.028365675339, 1929.3150931419284, 19177.3287934923, 19799.40601781949, 19841.30555430553, 19858.20567177311, 19858.70211946822, 2362.982226306629, 2395.35325462126, 2437.2566367257978, 2448.755124487555, 2466.469709012571, 137158.0, 138530.0, 139448.0, 140066.0, 140953.0, 14231.430742770173, 15217.847821521864, 15266.236688165547, 15340.698895165591, 15865.286062127232, 22769.544609108056, 23769.881150594483, 24231.273061808173, 24242.87878560596, 24265.150719724727, 9869.11177993984, 9879.209663226924, 10124.291299609104, 10247.38515689061, 10336.793264134676, 9123.406978546373, 9170.220531254918, 9191.77020574491, 9254.305927055499, 9303.441793492411, 9458.196053335543, 9474.95262523683, 9567.043295670517, 9593.568289426992, 9756.902430975599, 2868.5697145427935, 2884.4086962172705, 2884.4472641712237, 2908.520094184436, 2984.4031193761334, 955.6989548292265, 969.8302797010494, 984.9803003939882, 986.5166068626321, 988.2884323287221, 19538.413847584594, 19797.0, 19992.20031198736, 20510.0, 23732.762672373054, 1015.4465816130227, 1032.9070383665505, 1039.298473530364, 1067.770429357692, 1077.7036315013434, 11049.779004419866, 11276.887231127748, 11509.424528773528, 11624.011958983412, 13452.260125693181, 477397.0, 481239.0, 484375.0, 527432.0, 533813.0, 118760.40619796846, 119477.0, 121739.0, 124018.37990809989, 125119.0, 1249.375312343828, 1286.9935650321688, 1318.604418674413, 1319.399673148715, 1333.3866421446244, 19746.210151593776, 21123.366299011053, 21195.470113246676, 21333.893330533247, 21513.0, 57176.42823571878, 57775.0, 58044.70977645085, 59047.70476147592, 60304.0, 72946.0, 73003.90494142698, 73092.26907731067, 73277.6336118316, 73362.0, 14448.27758612044, 14705.779413308595, 14800.111993280438, 14877.776833347725, 14906.925465372604, 22692.546149076596, 23355.88322058379, 23482.295531134092, 23516.647250290916, 23625.29124126279, 18027.729584056513, 18681.719774203128, 18838.0, 19004.524886877938, 19034.428967131007, 15811.446599368966, 16461.67076658484, 16939.915300423912, 17296.91351543234, 17354.219060142575, 18577.53556161107, 19000.334988275343, 19369.70945435848, 19389.90305048522, 20440.897795510926, 14819.0, 14823.0, 14985.550433487013, 15028.17345046033, 15050.774238386213, 17809.0, 18779.90610046941, 18956.0521973898, 19062.428127156207, 19075.141618627473], "value": 12239.508542546058, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1355.1733442600016, 1417.8369487508933, 1424.6295963049604, 1437.9496717614882, 1440.6758479342143, 13604.183748975056, 14213.71572568548, 14281.143131412122, 14301.284935753196, 14311.069780464275, 11745.354005529693, 12222.388880555958, 13617.591472255823, 14125.434982600684, 14153.22157281349, 2704.6078318643836, 2733.221032005879, 2755.600437936508, 2757.1177223288555, 2762.1989623009304, 2550.132954795369, 2670.612761149632, 2751.7660998815027, 2756.6691996960294, 2762.599423083652, 2638.9472210555873, 2696.4202696420266, 2721.809473336867, 2738.137486691696, 2740.1779466160174, 2642.973570264292, 2674.0774432820745, 2695.0432596428377, 2696.44722831819, 2707.593860920858, 2601.6877974642975, 2604.7785938195275, 2605.6612640356634, 2614.6993095793846, 2617.149426436416, 13387.196768193842, 13562.254076025814, 13565.0, 13567.932160339134, 13618.046736728433, 7606.201348858401, 7911.9604401978195, 7922.207779222089, 7947.08608510023, 7957.164497727771, 5079.492050794928, 5205.27126202332, 5210.452902445227, 5268.947310526923, 5324.068288049576, 1858.7955324914249, 1897.250586018515, 1900.9049547522568, 1939.1177014458387, 1962.4995626115249, 22413.66379504309, 22562.0, 22658.09367625293, 22674.093036278693, 22819.543609127726, 6293.244810622663, 6478.805635830932, 6494.805155845333, 6636.502262330345, 6687.398134167948, 16151.273192706356, 16162.111083890499, 16164.595885102966, 16187.514374568782, 16197.59506012359, 7291.015712878693, 7544.660490277951, 7546.1321947976685, 7547.0943486781935, 7547.207543207994, 6456.870862582816, 6920.100386949765, 6939.097917270823, 7201.747938822116, 7212.675429605681, 4954.256861470808, 5063.974680126649, 5100.897982040338, 5139.254808052811, 5161.122609156452, 1290.2709968867748, 1335.5459143891123, 1458.2781523146111, 1463.817022872141, 1486.413640265951, 882.6381183714647, 883.2139395937621, 899.5547204133865, 916.6241840845355, 932.4591736792644, 7456.701731930771, 7546.924530754732, 7789.792582149776, 7914.762557123296, 8022.679092836222, 952.5665822050951, 994.4182653147844, 1002.0931057393071, 1007.3200589601989, 1027.6660085472251, 4353.455818022747, 4527.615152712056, 4979.05397974391, 4991.750412479361, 5031.647784655039, 18739.531511712044, 19376.903115484612, 19505.317313893946, 19583.412497625093, 19705.211791528465, 18862.81137188638, 19366.4190074298, 19512.414627561197, 19515.90242048809, 19628.70556941647, 10869.184811139196, 10878.673639790819, 10885.292455990335, 10986.340819550853, 11013.83479247812, 7695.807604809701, 7725.961370193113, 7895.328897043586, 7927.841443170989, 7973.401994850294, 15413.922930385725, 16332.673346532765, 16436.83563164353, 17254.0, 17316.740248896025, 15645.687086258438, 17263.223154957806, 17508.387206447715, 17549.473515794547, 17816.10919454048, 10978.341299522055, 11122.666320010412, 11196.440177991231, 11224.158188136085, 11224.719382015188, 12955.805662914876, 13103.118270994559, 13337.933310333774, 13355.53255636048, 13391.598252052065, 9071.59177837012, 9939.0, 10782.08352290064, 10950.123990080616, 11097.833532497181, 10058.899411006088, 10642.680719578426, 10688.091512221548, 10782.029617334478, 10958.890411096107, 9649.324547281623, 9768.0, 9771.609135634495, 9775.364601300893, 9781.902180978384, 6671.666416679243, 7080.150381953992, 7119.9644001781735, 7167.390771784457, 7283.890741638774, 6801.387875091265, 7007.754728584475, 7034.155901291878, 7187.460940429593, 7209.531380460253], "value": 6360.021155590908, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.22744518551076, 499.3957311652902, 529.8251576979598, 530.5649367518635, 533.2081858440216, 6272.968635156829, 6315.242170939488, 6331.52513561483, 6332.706992363968, 6361.618302901829, 6000.799840031989, 6092.725827337769, 6137.416945390192, 6167.907481387771, 6199.140257922616, 4914.189158788796, 4945.604351651859, 4947.688862451453, 4953.529414705597, 4984.32711583937, 4805.90388192236, 4955.529224723664, 4957.5786058185095, 4980.4272508661425, 4991.825286114987, 4953.727544985024, 4955.4548999610015, 4968.229924361712, 4972.751362431882, 4977.203647416414, 4932.80268789248, 4950.455449900508, 4973.179425394806, 4989.700617962933, 4994.250862370655, 4390.714603550759, 4479.70881892676, 4482.686211965164, 4499.775011249457, 4513.548645135493, 6011.218541589609, 6047.425494578008, 6080.665563394055, 6085.695715214221, 6142.907856382158, 5634.605577609569, 5663.791121462633, 5696.515796157331, 5748.396418376052, 5774.335951365605, 6381.425671689523, 6439.613623182624, 6481.28705842357, 6529.640869752162, 6586.661735084072, 4863.343448634424, 4887.169181239163, 4898.2652602109965, 4918.360613120307, 4947.381577302837, 6858.348456896587, 6903.206131294915, 6929.272426395206, 6937.445004399636, 6961.408280296181, 4975.402951645826, 4999.825006124841, 5022.874428139326, 5030.647854650212, 5055.620828437882, 5100.260462232955, 5108.259302401131, 5123.692578445305, 5129.666571672829, 5149.609605406519, 5620.57845661577, 5629.634073785191, 5687.459691329317, 5720.227769251181, 5767.798127065533, 6402.423781859655, 6425.228972523327, 6455.870882582322, 6523.18460192476, 6577.14497115372, 1687.64559442516, 1724.3878423159597, 1740.2169023939025, 1740.7301868210448, 1760.1815155952543, 1217.075022982522, 1217.7686239614445, 1235.8331625230658, 1245.3897590180745, 1264.8861602455638, 5646.124850648074, 5705.115707065329, 5744.339400968858, 5753.0, 5783.334916484658, 6554.344565543408, 6748.156480439945, 6762.357576030269, 6774.153230846145, 6776.7628133015105, 5784.681842498703, 5791.131330300404, 5797.130430435468, 5805.970970145207, 5820.854478638068, 3572.91067723309, 3599.1824128815306, 3600.927981440409, 3608.350496910529, 3615.240799432096, 6504.138179201136, 6513.576617519846, 6521.804345869631, 6539.313372095957, 6616.801495955129, 6673.264951112746, 6826.0, 6904.689288982008, 6922.169339679271, 6979.197392299849, 6469.805905822739, 6508.787012415802, 6525.2169739631545, 6551.296662867784, 6565.573237739627, 6689.49828762835, 6696.899546506904, 6718.782801675337, 6767.39093481589, 6792.490563207681, 6561.1470508833545, 6581.835454113494, 6669.7332106715185, 6731.293214212633, 6734.158230221223, 6475.611463312216, 6505.642189679613, 6514.0880276760345, 6544.934550654432, 6555.508336874849, 5029.371328583927, 5029.748512574283, 5042.546170844642, 5043.470435604208, 5063.316452278895, 6463.515236357386, 6696.83257918556, 6776.170433982698, 6780.186377634715, 6820.590764554143, 6006.489448396936, 6365.96817015912, 6388.105665206782, 6482.805515834532, 6487.513436492188, 6433.420992110732, 6462.676866156579, 6483.805485835433, 6510.511711621552, 6528.771492997722, 6317.96841015792, 6391.840203994937, 6398.776042838478, 6462.450691691259, 6497.18785151856, 6474.838129046811, 6503.837404064936, 6510.804675859732, 6527.738890444329, 6575.243846957661, 6258.311585725658, 6283.3088360281245, 6309.242890852944, 6316.684165791784, 6318.936810632019], "value": 5051.2980185934175, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [907.691384929124, 915.569682249343, 931.9254459643229, 938.1462868789403, 946.9479178645174, 17690.734638980408, 18709.719354209697, 18741.0, 18776.90611546944, 18785.0, 19922.0, 21963.780362196372, 21998.450038749, 22046.33860984173, 22145.0, 1046.8429735539673, 1050.4380156616212, 1059.5391004912888, 1060.5598676549223, 1063.0538820449806, 977.6529332087114, 1044.69703785902, 1055.5619417941584, 1062.102523367757, 1063.0379506546587, 1115.3029356652091, 1117.636768050383, 1124.3029321820484, 1124.4040658450992, 1126.881677423871, 1112.2992514715718, 1114.309128340426, 1116.112690411117, 1119.5018216893486, 1120.4117838135003, 813.7640084375524, 817.1624085312602, 817.9672813087469, 818.1818181818181, 819.713100414856, 17406.82593174065, 17861.106944652845, 19436.0, 19681.803181968142, 19721.40835774929, 20722.0, 20783.376498705064, 21149.25977590777, 21214.0, 21378.358649240392, 16246.431374901822, 16606.169691515377, 16739.497815065446, 16748.078855663054, 16750.246238919277, 3534.3108093921696, 3554.5556805399324, 3555.4489054196642, 3562.09166662502, 3569.7322700797545, 112706.0, 113869.0, 115558.0, 126272.0, 127941.0, 16755.41356052532, 16870.578235543962, 16928.153592320334, 16928.238229279465, 17035.829641703673, 29406.411871762444, 31277.687223127934, 31392.215194620316, 31525.0, 31536.684633153833, 8561.529115898686, 8750.956245218733, 8830.470171789584, 8835.0, 8835.293176545989, 4046.9392959105635, 4111.6299533042165, 4124.4019617155345, 4129.2773764591075, 4136.710430269913, 4713.363695901078, 4993.550580447704, 5148.716820574904, 6032.185654936615, 6080.483158931452, 1092.1317552545745, 1118.4799068433217, 1131.3551275772732, 1138.612871623652, 1142.948567314473, 673.9797806065826, 674.6120980436269, 685.5749435350115, 719.1873183302835, 729.4055344893894, 12332.19840710351, 12460.190087644274, 12464.81302780459, 12489.625311240678, 12816.80774788379, 639.788869673016, 671.4561205423622, 677.0656494038195, 694.0318256032806, 696.905917701114, 5238.685678859204, 5475.315585551806, 5723.456271654186, 6098.26820781509, 6231.937680623136, 99822.0, 106007.46996264969, 111473.44263278793, 111911.44044279726, 113687.0, 94025.52987235157, 95451.0, 95628.52185739166, 96174.51912740532, 98105.50947245218, 79939.60030199928, 79966.60016699879, 80986.59506702429, 84928.57535712281, 91228.08771912196, 12157.69605759863, 12943.352832358532, 13002.739945201232, 13050.4127314273, 13507.527236546674, 36315.27369452649, 37397.6260237405, 38339.0, 38607.80696096501, 40639.39040914329, 45601.77199114116, 47333.0, 48112.75943620259, 49068.75465622792, 50487.49512504975, 18619.162137703566, 18847.15187816524, 19078.23687052558, 19270.61458770845, 19399.612007760046, 20992.475188120417, 21359.03884325178, 21470.463238419165, 21549.707017578996, 21599.568008640053, 18182.181801818686, 18203.908980455013, 18238.635227295115, 18642.254309827997, 18722.25110995545, 17362.305507779547, 17863.910680447036, 17930.0, 18255.0, 18630.53423664419, 17638.647227055644, 17907.73138402951, 17921.820781792536, 18128.81871181324, 18169.27322907122, 12700.237985720887, 12846.357682116044, 13037.934810326267, 13441.260730659907, 13662.521811736542, 13017.153884997444, 13220.537281195113, 13255.469781208643, 13434.126781759154, 13899.16605003703], "value": 9146.066035633376, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 109.0, 102.0, 108.0, 110.0, 116.0, 109.0, 100.0, 111.0, 112.0], "value": 107.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 118.0, 143.0, 174.0, 123.0, 143.0, 152.0, 119.0, 176.0, 119.0], "value": 141.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 163.0, 163.0, 163.0, 162.0, 163.0, 169.0, 169.0, 162.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 172.0, 77.0, 77.0, 73.0, 76.0, 155.0, 77.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 137.0, 81.0, 81.0, 81.0, 138.0, 81.0, 82.0, 135.0], "value": 97.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 115.0, 114.0, 114.0, 113.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 150.0, 150.0, 152.0, 150.0, 151.0, 150.0, 150.0, 151.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 96.0, 99.0, 93.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 70.0, 55.0, 55.0, 56.0, 55.0, 54.0, 56.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 54.0, 54.0, 53.0, 60.0, 54.0, 54.0, 54.0], "value": 54.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 78.0, 79.0, 78.0, 77.0, 79.0, 86.0, 79.0, 86.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 141.0, 145.0, 125.0, 127.0, 147.0, 127.0, 139.0, 126.0, 170.0], "value": 137.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 193.0, 172.0, 176.0, 182.0, 194.0, 174.0, 180.0, 177.0, 172.0], "value": 179.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 81.0, 66.0, 75.0, 70.0, 68.0, 70.0, 66.0, 70.0, 68.0], "value": 70.2, "unit": "score"}]}]} 06:32:03 INFO - Return code: 0 06:32:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:32:03 INFO - # TBPL SUCCESS # 06:32:03 INFO - Running post-action listener: _package_coverage_data 06:32:03 INFO - Running post-action listener: _resource_record_post_action 06:32:03 INFO - [mozharness: 2017-07-25 13:32:03.156892Z] Finished run-tests step (success) 06:32:03 INFO - Running post-run listener: _resource_record_post_run 06:32:03 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 437760000; Read time: 0; Write time: 338728 06:32:03 INFO - TinderboxPrint: CPU usage
13.1% 06:32:03 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:32:03 INFO - TinderboxPrint: I/O write bytes / time
437,760,000 / 338,728 06:32:03 INFO - TinderboxPrint: CPU idle
8,265.7 (86.8%) 06:32:03 INFO - TinderboxPrint: CPU user
1,202.9 (12.6%) 06:32:03 INFO - TinderboxPrint: Swap in / out
0 / 0 06:32:03 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 109764608; Read time: 0; Write time: 108584 06:32:03 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 06:32:03 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 327995392; Read time: 0; Write time: 230144 06:32:03 INFO - Running post-run listener: _upload_blobber_files 06:32:03 INFO - Blob upload gear active. 06:32:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:32:03 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 06:32:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:32:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:32:04 INFO - (blobuploader) - INFO - Open directory for files ... 06:32:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:32:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:32:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:32:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:32:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:32:04 INFO - (blobuploader) - INFO - Done attempting. 06:32:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:32:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:32:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:32:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:32:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:32:05 INFO - (blobuploader) - INFO - Done attempting. 06:32:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:32:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:32:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:32:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:32:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:32:06 INFO - (blobuploader) - INFO - Done attempting. 06:32:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:32:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:32:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:32:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:32:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:32:12 INFO - (blobuploader) - INFO - Done attempting. 06:32:12 INFO - (blobuploader) - INFO - Iteration through files over. 06:32:12 INFO - Return code: 0 06:32:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:32:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:32:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2245a0290e9c2075520c244ca11a7b81bc5b9a1fdc961c4e867fedb254f69eae9e554476205b221482f245d97df68511553bc944fccd87b5df0a083d6f5ce74c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c08f6cee4d02aa1ca762ebadd384fc6d1132ab632671da9077ba6e7fd3566e80992312d46f864387ba7934837420f26cb20de4af8aa0c43f92c3cfaf88b4c2e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6e4e26262cea51a76c423c093659f541553b0ed0f3f9894a104eaa6d9c1e9da608f6d406f5765ca20e7c93ae204a878c25abc01b6cf4d7e1e937859080cd936", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8c5baa4c732965922104bd7eb9ab4d2826451ac6c5d3263192481e0ba8f2ec0b47942c4dbbbad691b86fb9832e2f2b0bff6680c523cfec248f926dc0b50fd07"} 06:32:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:32:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:32:12 INFO - Contents: 06:32:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2245a0290e9c2075520c244ca11a7b81bc5b9a1fdc961c4e867fedb254f69eae9e554476205b221482f245d97df68511553bc944fccd87b5df0a083d6f5ce74c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c08f6cee4d02aa1ca762ebadd384fc6d1132ab632671da9077ba6e7fd3566e80992312d46f864387ba7934837420f26cb20de4af8aa0c43f92c3cfaf88b4c2e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6e4e26262cea51a76c423c093659f541553b0ed0f3f9894a104eaa6d9c1e9da608f6d406f5765ca20e7c93ae204a878c25abc01b6cf4d7e1e937859080cd936", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8c5baa4c732965922104bd7eb9ab4d2826451ac6c5d3263192481e0ba8f2ec0b47942c4dbbbad691b86fb9832e2f2b0bff6680c523cfec248f926dc0b50fd07"} 06:32:12 INFO - Running post-run listener: copy_logs_to_upload_dir 06:32:12 INFO - Copying logs to upload dir... 06:32:12 INFO - mkdir: /builds/slave/test/build/upload/logs 06:32:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.746612 ========= master_lag: -0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-07-25 06:32:12.413635) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-25 06:32:12.418329) ========= 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=2432103b8b3de4003b23cad4000001c2-1500986867.599003-1155191702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2245a0290e9c2075520c244ca11a7b81bc5b9a1fdc961c4e867fedb254f69eae9e554476205b221482f245d97df68511553bc944fccd87b5df0a083d6f5ce74c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c08f6cee4d02aa1ca762ebadd384fc6d1132ab632671da9077ba6e7fd3566e80992312d46f864387ba7934837420f26cb20de4af8aa0c43f92c3cfaf88b4c2e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6e4e26262cea51a76c423c093659f541553b0ed0f3f9894a104eaa6d9c1e9da608f6d406f5765ca20e7c93ae204a878c25abc01b6cf4d7e1e937859080cd936", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8c5baa4c732965922104bd7eb9ab4d2826451ac6c5d3263192481e0ba8f2ec0b47942c4dbbbad691b86fb9832e2f2b0bff6680c523cfec248f926dc0b50fd07"} build_url:https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011346 build_url: 'https://queue.taskcluster.net/v1/task/blOgpJOoQfmX7a7f7IMY-A/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2245a0290e9c2075520c244ca11a7b81bc5b9a1fdc961c4e867fedb254f69eae9e554476205b221482f245d97df68511553bc944fccd87b5df0a083d6f5ce74c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c08f6cee4d02aa1ca762ebadd384fc6d1132ab632671da9077ba6e7fd3566e80992312d46f864387ba7934837420f26cb20de4af8aa0c43f92c3cfaf88b4c2e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6e4e26262cea51a76c423c093659f541553b0ed0f3f9894a104eaa6d9c1e9da608f6d406f5765ca20e7c93ae204a878c25abc01b6cf4d7e1e937859080cd936", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8c5baa4c732965922104bd7eb9ab4d2826451ac6c5d3263192481e0ba8f2ec0b47942c4dbbbad691b86fb9832e2f2b0bff6680c523cfec248f926dc0b50fd07"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-25 06:32:12.442400) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 06:32:12.442699) ========= 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=2432103b8b3de4003b23cad4000001c2-1500986867.599003-1155191702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004472 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 06:32:12.527784) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-25 06:32:12.530109) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-25 06:32:12.530387) ========= ========= Total master_lag: 0.12 =========