builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-086 starttime: 1496367566.95 results: success (0) revision: 877c3da58fa35bf4e58f2ac0cbcf59840702cc6e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-01 18:39:26.950242) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-01 18:39:26.950659) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-01 18:39:26.950931) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-01 18:39:26.989541) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 18:39:26.989801) ========= 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=438111f3d31ce799eff2119d000001bc-1496366126.471363-2005779219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-01 18:39:27-- 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% 17.4M=0.001s 2017-06-01 18:39:27 (17.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123969 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 18:39:27.142071) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 18:39:27.142369) ========= 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=438111f3d31ce799eff2119d000001bc-1496366126.471363-2005779219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020698 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 18:39:27.203110) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-01 18:39:27.203471) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 877c3da58fa35bf4e58f2ac0cbcf59840702cc6e --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 877c3da58fa35bf4e58f2ac0cbcf59840702cc6e --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=438111f3d31ce799eff2119d000001bc-1496366126.471363-2005779219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-01 18:39:27,550 truncating revision to first 12 chars 2017-06-01 18:39:27,550 Setting DEBUG logging. 2017-06-01 18:39:27,550 attempt 1/10 2017-06-01 18:39:27,550 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/877c3da58fa3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-01 18:39:28,637 unpacking tar archive at: mozilla-central-877c3da58fa3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.455995 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-01 18:39:28.674332) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-01 18:39:28.674658) ========= script_repo_revision: 877c3da58fa35bf4e58f2ac0cbcf59840702cc6e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-01 18:39:28.675075) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-01 18:39:28.675899) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-01 18:39:28.692702) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 2 secs) (at 2017-06-01 18:39:28.693032) ========= /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=438111f3d31ce799eff2119d000001bc-1496366126.471363-2005779219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:39:29 INFO - MultiFileLogger online at 20170601 18:39:29 in /builds/slave/test 18:39:29 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 18:39:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:39:29 INFO - {'append_to_log': False, 18:39:29 INFO - 'base_work_dir': '/builds/slave/test', 18:39:29 INFO - 'blob_upload_branch': 'Firefox', 18:39:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:39:29 INFO - 'branch': 'Firefox', 18:39:29 INFO - 'buildbot_json_path': 'buildprops.json', 18:39:29 INFO - 'config_files': ('talos/linux_config.py',), 18:39:29 INFO - 'default_actions': ('clobber', 18:39:29 INFO - 'read-buildbot-config', 18:39:29 INFO - 'download-and-extract', 18:39:29 INFO - 'populate-webroot', 18:39:29 INFO - 'create-virtualenv', 18:39:29 INFO - 'install', 18:39:29 INFO - 'setup-mitmproxy', 18:39:29 INFO - 'run-tests'), 18:39:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:39:29 INFO - 'download_minidump_stackwalk': True, 18:39:29 INFO - 'download_symbols': 'ondemand', 18:39:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:39:29 INFO - 'tooltool.py': '/tools/tooltool.py', 18:39:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:39:29 INFO - '/tools/misc-python/virtualenv.py')}, 18:39:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:39:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:39:29 INFO - 'gecko_profile': False, 18:39:29 INFO - 'gecko_profile_interval': 0, 18:39:29 INFO - 'installer_path': 'installer.exe', 18:39:29 INFO - 'log_level': 'info', 18:39:29 INFO - 'log_name': 'talos', 18:39:29 INFO - 'log_to_console': True, 18:39:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:39:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:39:29 INFO - 'opt_config_files': (), 18:39:29 INFO - 'pip_index': False, 18:39:29 INFO - 'suite': 'dromaeojs-e10s', 18:39:29 INFO - 'system_bits': '32', 18:39:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:39:29 INFO - 'title': 'talos-linux64-ix-086', 18:39:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:39:29 INFO - 'use_talos_json': True, 18:39:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:39:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:39:29 INFO - 'work_dir': 'build'} 18:39:29 INFO - [mozharness: 2017-06-02 01:39:29.138089Z] Running clobber step. 18:39:29 INFO - Running pre-action listener: _resource_record_pre_action 18:39:29 INFO - Running main action method: clobber 18:39:29 INFO - rmtree: /builds/slave/test/build 18:39:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:39:30 INFO - Running post-action listener: _resource_record_post_action 18:39:30 INFO - [mozharness: 2017-06-02 01:39:30.659724Z] Finished clobber step (success) 18:39:30 INFO - [mozharness: 2017-06-02 01:39:30.659825Z] Running read-buildbot-config step. 18:39:30 INFO - Running pre-action listener: _resource_record_pre_action 18:39:30 INFO - Running main action method: read_buildbot_config 18:39:30 INFO - Using buildbot properties: 18:39:30 INFO - { 18:39:30 INFO - "project": "", 18:39:30 INFO - "product": "firefox", 18:39:30 INFO - "who": "ffxbld@noreply.mozilla.org", 18:39:30 INFO - "installer_path": "public/build/target.tar.bz2", 18:39:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 18:39:30 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 18:39:30 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 18:39:30 INFO - "stage_platform": "linux64-stylo", 18:39:30 INFO - "basedir": "/builds/slave/test", 18:39:30 INFO - "buildnumber": 129, 18:39:30 INFO - "platform": "ubuntu64_hw_stylo", 18:39:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:39:30 INFO - "slavebuilddir": "test", 18:39:30 INFO - "taskId": "Yj2KSDDSSFaNGk9XclNzVA", 18:39:30 INFO - "branch": "mozilla-central", 18:39:30 INFO - "script_repo_revision": "production", 18:39:30 INFO - "revision": "877c3da58fa35bf4e58f2ac0cbcf59840702cc6e", 18:39:30 INFO - "slavename": "talos-linux64-ix-086", 18:39:30 INFO - "repo_path": "mozilla-central" 18:39:30 INFO - } 18:39:30 INFO - Finding installer, test and symbols from parent task. 18:39:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yj2KSDDSSFaNGk9XclNzVA'}, attempt #1 18:39:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yj2KSDDSSFaNGk9XclNzVA'}, attempt #1 18:39:31 INFO - Task dependencies: M01p551nRICde_z2WO7G_w 18:39:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M01p551nRICde_z2WO7G_w'}, attempt #1 18:39:32 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/M01p551nRICde_z2WO7G_w/artifacts/public/build/target.tar.bz2 18:39:32 INFO - Set test_url: https://queue.taskcluster.net/v1/task/M01p551nRICde_z2WO7G_w/artifacts/public/build/test_packages.json 18:39:32 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/M01p551nRICde_z2WO7G_w/artifacts/public/build/target.crashreporter-symbols.zip 18:39:32 INFO - Running post-action listener: _resource_record_post_action 18:39:32 INFO - [mozharness: 2017-06-02 01:39:32.008111Z] Finished read-buildbot-config step (success) 18:39:32 INFO - [mozharness: 2017-06-02 01:39:32.008332Z] Running download-and-extract step. 18:39:32 INFO - Running pre-action listener: _resource_record_pre_action 18:39:32 INFO - Running main action method: download_and_extract 18:39:32 INFO - mkdir: /builds/slave/test/build/tests 18:39:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:39:32 INFO - trying https://queue.taskcluster.net/v1/task/M01p551nRICde_z2WO7G_w/artifacts/public/build/target.test_packages.json 18:39:32 INFO - Downloading https://queue.taskcluster.net/v1/task/M01p551nRICde_z2WO7G_w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:39:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M01p551nRICde_z2WO7G_w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:39:32 INFO - Downloaded 986 bytes. 18:39:32 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:39:32 INFO - Using the following test package requirements: 18:39:32 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:39:32 INFO - u'common': [u'target.common.tests.zip'], 18:39:32 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:39:32 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:39:32 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:39:32 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:39:32 INFO - u'mozbase': [u'target.common.tests.zip'], 18:39:32 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:39:32 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:39:32 INFO - u'web-platform': [u'target.common.tests.zip', 18:39:32 INFO - u'target.web-platform.tests.zip'], 18:39:32 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:39:32 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:39:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M01p551nRICde_z2WO7G_w/artifacts/public/build/target.common.tests.zip 18:39:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M01p551nRICde_z2WO7G_w/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:39:32 INFO - Fetch https://queue.taskcluster.net/v1/task/M01p551nRICde_z2WO7G_w/artifacts/public/build/target.common.tests.zip into memory 18:39:36 INFO - Content-Length response header: 63530678 18:39:36 INFO - Bytes received: 63530678 18:39:46 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:39:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M01p551nRICde_z2WO7G_w/artifacts/public/build/target.common.tests.zip 18:39:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M01p551nRICde_z2WO7G_w/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:39:46 INFO - Fetch https://queue.taskcluster.net/v1/task/M01p551nRICde_z2WO7G_w/artifacts/public/build/target.common.tests.zip into memory 18:39:49 INFO - Content-Length response header: 63530678 18:39:49 INFO - Bytes received: 63530678 18:40:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M01p551nRICde_z2WO7G_w/artifacts/public/build/target.talos.tests.zip 18:40:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M01p551nRICde_z2WO7G_w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:40:01 INFO - Fetch https://queue.taskcluster.net/v1/task/M01p551nRICde_z2WO7G_w/artifacts/public/build/target.talos.tests.zip into memory 18:40:03 INFO - Content-Length response header: 14447425 18:40:03 INFO - Bytes received: 14447425 18:40:03 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')]} 18:40:03 INFO - trying https://queue.taskcluster.net/v1/task/M01p551nRICde_z2WO7G_w/artifacts/public/build/target.tar.bz2 18:40:03 INFO - Downloading https://queue.taskcluster.net/v1/task/M01p551nRICde_z2WO7G_w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:40:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M01p551nRICde_z2WO7G_w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:40:06 INFO - Downloaded 55886961 bytes. 18:40:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M01p551nRICde_z2WO7G_w/artifacts/public/build/target.tar.bz2 18:40:06 INFO - mkdir: /builds/slave/test/properties 18:40:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:40:06 INFO - Writing to file /builds/slave/test/properties/build_url 18:40:06 INFO - Contents: 18:40:06 INFO - build_url:https://queue.taskcluster.net/v1/task/M01p551nRICde_z2WO7G_w/artifacts/public/build/target.tar.bz2 18:40:06 INFO - Running post-action listener: _resource_record_post_action 18:40:06 INFO - Running post-action listener: set_extra_try_arguments 18:40:06 INFO - [mozharness: 2017-06-02 01:40:06.717026Z] Finished download-and-extract step (success) 18:40:06 INFO - [mozharness: 2017-06-02 01:40:06.717262Z] Running populate-webroot step. 18:40:06 INFO - Running pre-action listener: _resource_record_pre_action 18:40:06 INFO - Running main action method: populate_webroot 18:40:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:40:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:40:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:40:06 INFO - '--tppagecycles', 18:40:06 INFO - '7'], 18:40:06 INFO - 'tests': ['tsvgm']}}, 18:40:06 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:40:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:40:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:40:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:40:06 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:40:06 INFO - 'talos_options': ['--disable-e10s'], 18:40:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:40:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:40:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:40:06 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:40:06 INFO - 'talos_options': ['--disable-e10s'], 18:40:06 INFO - 'tests': ['damp', 'tps']}, 18:40:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:40:06 INFO - 'tests': ['damp', 'tps']}, 18:40:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:40:06 INFO - 'tests': ['dromaeo_dom']}, 18:40:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:40:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:40:06 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 18:40:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:40:06 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:40:06 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:40:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:40:06 INFO - 'tests': ['a11yr', 18:40:06 INFO - 'ts_paint', 18:40:06 INFO - 'tpaint', 18:40:06 INFO - 'sessionrestore', 18:40:06 INFO - 'sessionrestore_no_auto_restore', 18:40:06 INFO - 'tabpaint']}, 18:40:06 INFO - 'other-e10s': {'tests': ['a11yr', 18:40:06 INFO - 'ts_paint', 18:40:06 INFO - 'tpaint', 18:40:06 INFO - 'sessionrestore', 18:40:06 INFO - 'sessionrestore_no_auto_restore', 18:40:06 INFO - 'tabpaint']}, 18:40:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:40:06 INFO - 'ts_paint', 18:40:06 INFO - 'tpaint', 18:40:06 INFO - 'sessionrestore', 18:40:06 INFO - 'sessionrestore_no_auto_restore', 18:40:06 INFO - 'tabpaint']}, 18:40:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:40:06 INFO - 'ts_paint', 18:40:06 INFO - 'tpaint', 18:40:06 INFO - 'sessionrestore', 18:40:06 INFO - 'sessionrestore_no_auto_restore', 18:40:06 INFO - 'tabpaint']}, 18:40:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:40:06 INFO - 'tests': ['a11yr', 18:40:06 INFO - 'ts_paint', 18:40:06 INFO - 'tpaint', 18:40:06 INFO - 'sessionrestore', 18:40:06 INFO - 'sessionrestore_no_auto_restore', 18:40:06 INFO - 'tabpaint']}, 18:40:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:40:06 INFO - 'tests': ['a11yr', 18:40:06 INFO - 'ts_paint', 18:40:06 INFO - 'tpaint', 18:40:06 INFO - 'sessionrestore', 18:40:06 INFO - 'sessionrestore_no_auto_restore', 18:40:06 INFO - 'tabpaint']}, 18:40:06 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 18:40:06 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 18:40:06 INFO - 'bloom_basic_ref']}, 18:40:06 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 18:40:06 INFO - 'talos_options': ['--mitmproxy', 18:40:06 INFO - 'mitmproxy-recording-1.mp', 18:40:06 INFO - '--firstNonBlankPaint'], 18:40:06 INFO - 'tests': ['Quantum_1']}, 18:40:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:40:06 INFO - 'tests': ['tsvgx', 18:40:06 INFO - 'tsvgr_opacity', 18:40:06 INFO - 'tart', 18:40:06 INFO - 'tscrollx', 18:40:06 INFO - 'cart', 18:40:06 INFO - 'tsvg_static']}, 18:40:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:40:06 INFO - 'tsvgr_opacity', 18:40:06 INFO - 'tart', 18:40:06 INFO - 'tscrollx', 18:40:06 INFO - 'cart', 18:40:06 INFO - 'tsvg_static']}, 18:40:06 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:40:06 INFO - 'talos_options': ['--disable-e10s'], 18:40:06 INFO - 'tests': ['tp5o']}, 18:40:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:40:06 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:40:06 INFO - 'talos_options': ['--disable-e10s', 18:40:06 INFO - '--xperf_path', 18:40:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:40:06 INFO - 'tests': ['tp5n']}, 18:40:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:40:06 INFO - 'talos_options': ['--xperf_path', 18:40:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:40:06 INFO - 'tests': ['tp5n']}}, 18:40:06 INFO - 'talos.zip': {'path': '', 18:40:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:40:06 INFO - Running post-action listener: _resource_record_post_action 18:40:06 INFO - [mozharness: 2017-06-02 01:40:06.734052Z] Finished populate-webroot step (success) 18:40:06 INFO - [mozharness: 2017-06-02 01:40:06.734147Z] Running create-virtualenv step. 18:40:06 INFO - Running pre-action listener: _resource_record_pre_action 18:40:06 INFO - Running main action method: create_virtualenv 18:40:06 INFO - Creating virtualenv /builds/slave/test/build/venv 18:40:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:40:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:40:06 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:40:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:40:06 INFO - Using real prefix '/usr' 18:40:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:40:07 INFO - Installing distribute.............................................................................................................................................................................................done. 18:40:09 INFO - Installing pip.................done. 18:40:09 INFO - Return code: 0 18:40:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:40:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:40:09 INFO - Reading from file tmpfile_stdout 18:40:09 INFO - Output received: 18:40:09 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:40:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:40:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bd3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a97a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c38840>, '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 0x2c39740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c39bd0>, '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': '438111f3d31ce799eff2119d000001bc-1496366126.471363-2005779219', '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 18:40:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:40:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:40:09 INFO - Using env: {'DISPLAY': ':0', 18:40:09 INFO - 'HOME': '/home/cltbld', 18:40:09 INFO - 'LANG': 'en_US.UTF-8', 18:40:09 INFO - 'LANGUAGE': 'en_US:en', 18:40:09 INFO - 'LOGNAME': 'cltbld', 18:40:09 INFO - 'MAIL': '/var/mail/cltbld', 18:40:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:09 INFO - 'MOZ_NO_REMOTE': '1', 18:40:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:09 INFO - 'NO_EM_RESTART': '1', 18:40:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:09 INFO - 'PWD': '/builds/slave/test', 18:40:09 INFO - 'SHELL': '/bin/bash', 18:40:09 INFO - 'SHLVL': '1', 18:40:09 INFO - 'TERM': 'linux', 18:40:09 INFO - 'TMOUT': '86400', 18:40:09 INFO - 'USER': 'cltbld', 18:40:09 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1496366126.471363-2005779219', 18:40:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:09 INFO - '_': '/tools/buildbot/bin/python'} 18:40:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:09 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:40:09 INFO - Cleaning up... 18:40:09 INFO - Return code: 0 18:40:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:40:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bd3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a97a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c38840>, '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 0x2c39740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c39bd0>, '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': '438111f3d31ce799eff2119d000001bc-1496366126.471363-2005779219', '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 18:40:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:40:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:40:09 INFO - Using env: {'DISPLAY': ':0', 18:40:09 INFO - 'HOME': '/home/cltbld', 18:40:09 INFO - 'LANG': 'en_US.UTF-8', 18:40:09 INFO - 'LANGUAGE': 'en_US:en', 18:40:09 INFO - 'LOGNAME': 'cltbld', 18:40:09 INFO - 'MAIL': '/var/mail/cltbld', 18:40:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:09 INFO - 'MOZ_NO_REMOTE': '1', 18:40:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:09 INFO - 'NO_EM_RESTART': '1', 18:40:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:09 INFO - 'PWD': '/builds/slave/test', 18:40:09 INFO - 'SHELL': '/bin/bash', 18:40:09 INFO - 'SHLVL': '1', 18:40:09 INFO - 'TERM': 'linux', 18:40:09 INFO - 'TMOUT': '86400', 18:40:09 INFO - 'USER': 'cltbld', 18:40:09 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1496366126.471363-2005779219', 18:40:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:09 INFO - '_': '/tools/buildbot/bin/python'} 18:40:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:09 INFO - Downloading/unpacking psutil>=3.1.1 18:40:09 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 18:40:09 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 18:40:09 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 18:40:09 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 18:40:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:40:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:40:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:40:11 INFO - Installing collected packages: psutil 18:40:11 INFO - Running setup.py install for psutil 18:40:11 INFO - building 'psutil._psutil_linux' extension 18:40:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:40:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:40:11 INFO - building 'psutil._psutil_posix' extension 18:40:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:40:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:40:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:40:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:40:11 INFO - Successfully installed psutil 18:40:11 INFO - Cleaning up... 18:40:11 INFO - Return code: 0 18:40:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:40:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bd3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a97a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c38840>, '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 0x2c39740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c39bd0>, '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': '438111f3d31ce799eff2119d000001bc-1496366126.471363-2005779219', '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 18:40:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:40:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:40:11 INFO - Using env: {'DISPLAY': ':0', 18:40:11 INFO - 'HOME': '/home/cltbld', 18:40:11 INFO - 'LANG': 'en_US.UTF-8', 18:40:11 INFO - 'LANGUAGE': 'en_US:en', 18:40:11 INFO - 'LOGNAME': 'cltbld', 18:40:11 INFO - 'MAIL': '/var/mail/cltbld', 18:40:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:11 INFO - 'MOZ_NO_REMOTE': '1', 18:40:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:11 INFO - 'NO_EM_RESTART': '1', 18:40:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:11 INFO - 'PWD': '/builds/slave/test', 18:40:11 INFO - 'SHELL': '/bin/bash', 18:40:11 INFO - 'SHLVL': '1', 18:40:11 INFO - 'TERM': 'linux', 18:40:11 INFO - 'TMOUT': '86400', 18:40:11 INFO - 'USER': 'cltbld', 18:40:11 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1496366126.471363-2005779219', 18:40:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:11 INFO - '_': '/tools/buildbot/bin/python'} 18:40:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:40:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:40:13 INFO - Installing collected packages: mozsystemmonitor 18:40:13 INFO - Running setup.py install for mozsystemmonitor 18:40:13 INFO - Successfully installed mozsystemmonitor 18:40:13 INFO - Cleaning up... 18:40:13 INFO - Return code: 0 18:40:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:40:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bd3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a97a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c38840>, '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 0x2c39740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c39bd0>, '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': '438111f3d31ce799eff2119d000001bc-1496366126.471363-2005779219', '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 18:40:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:40:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:40:13 INFO - Using env: {'DISPLAY': ':0', 18:40:13 INFO - 'HOME': '/home/cltbld', 18:40:13 INFO - 'LANG': 'en_US.UTF-8', 18:40:13 INFO - 'LANGUAGE': 'en_US:en', 18:40:13 INFO - 'LOGNAME': 'cltbld', 18:40:13 INFO - 'MAIL': '/var/mail/cltbld', 18:40:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:13 INFO - 'MOZ_NO_REMOTE': '1', 18:40:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:13 INFO - 'NO_EM_RESTART': '1', 18:40:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:13 INFO - 'PWD': '/builds/slave/test', 18:40:13 INFO - 'SHELL': '/bin/bash', 18:40:13 INFO - 'SHLVL': '1', 18:40:13 INFO - 'TERM': 'linux', 18:40:13 INFO - 'TMOUT': '86400', 18:40:13 INFO - 'USER': 'cltbld', 18:40:13 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1496366126.471363-2005779219', 18:40:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:13 INFO - '_': '/tools/buildbot/bin/python'} 18:40:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:13 INFO - Downloading/unpacking jsonschema==2.5.1 18:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:40:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:14 INFO - Downloading functools32-3.2.3-2.tar.gz 18:40:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:40:14 INFO - warning: no files found matching '*.txt' 18:40:14 INFO - no previously-included directories found matching 'build' 18:40:14 INFO - no previously-included directories found matching 'dist' 18:40:14 INFO - no previously-included directories found matching '.git*' 18:40:14 INFO - Installing collected packages: jsonschema, functools32 18:40:14 INFO - Running setup.py install for functools32 18:40:14 INFO - warning: no files found matching '*.txt' 18:40:14 INFO - no previously-included directories found matching 'build' 18:40:14 INFO - no previously-included directories found matching 'dist' 18:40:14 INFO - no previously-included directories found matching '.git*' 18:40:14 INFO - Successfully installed jsonschema functools32 18:40:14 INFO - Cleaning up... 18:40:14 INFO - Return code: 0 18:40:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bd3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a97a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c38840>, '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 0x2c39740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c39bd0>, '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': '438111f3d31ce799eff2119d000001bc-1496366126.471363-2005779219', '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 18:40:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:40:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:40:14 INFO - Using env: {'DISPLAY': ':0', 18:40:14 INFO - 'HOME': '/home/cltbld', 18:40:14 INFO - 'LANG': 'en_US.UTF-8', 18:40:14 INFO - 'LANGUAGE': 'en_US:en', 18:40:14 INFO - 'LOGNAME': 'cltbld', 18:40:14 INFO - 'MAIL': '/var/mail/cltbld', 18:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:14 INFO - 'MOZ_NO_REMOTE': '1', 18:40:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:14 INFO - 'NO_EM_RESTART': '1', 18:40:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:14 INFO - 'PWD': '/builds/slave/test', 18:40:14 INFO - 'SHELL': '/bin/bash', 18:40:14 INFO - 'SHLVL': '1', 18:40:14 INFO - 'TERM': 'linux', 18:40:14 INFO - 'TMOUT': '86400', 18:40:14 INFO - 'USER': 'cltbld', 18:40:14 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1496366126.471363-2005779219', 18:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:14 INFO - '_': '/tools/buildbot/bin/python'} 18:40:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:40:15 INFO - Cleaning up... 18:40:15 INFO - Return code: 0 18:40:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bd3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a97a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c38840>, '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 0x2c39740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c39bd0>, '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': '438111f3d31ce799eff2119d000001bc-1496366126.471363-2005779219', '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 18:40:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:40:15 INFO - Using env: {'DISPLAY': ':0', 18:40:15 INFO - 'HOME': '/home/cltbld', 18:40:15 INFO - 'LANG': 'en_US.UTF-8', 18:40:15 INFO - 'LANGUAGE': 'en_US:en', 18:40:15 INFO - 'LOGNAME': 'cltbld', 18:40:15 INFO - 'MAIL': '/var/mail/cltbld', 18:40:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:15 INFO - 'MOZ_NO_REMOTE': '1', 18:40:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:15 INFO - 'NO_EM_RESTART': '1', 18:40:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:15 INFO - 'PWD': '/builds/slave/test', 18:40:15 INFO - 'SHELL': '/bin/bash', 18:40:15 INFO - 'SHLVL': '1', 18:40:15 INFO - 'TERM': 'linux', 18:40:15 INFO - 'TMOUT': '86400', 18:40:15 INFO - 'USER': 'cltbld', 18:40:15 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1496366126.471363-2005779219', 18:40:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:15 INFO - '_': '/tools/buildbot/bin/python'} 18:40:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:15 INFO - Downloading/unpacking blobuploader==1.2.4 18:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:16 INFO - Downloading blobuploader-1.2.4.tar.gz 18:40:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:40:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:40:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:40:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:40:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:16 INFO - Downloading docopt-0.6.1.tar.gz 18:40:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:40:16 INFO - Installing collected packages: blobuploader, requests, docopt 18:40:16 INFO - Running setup.py install for blobuploader 18:40:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:40:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:40:17 INFO - Running setup.py install for requests 18:40:17 INFO - Running setup.py install for docopt 18:40:17 INFO - Successfully installed blobuploader requests docopt 18:40:17 INFO - Cleaning up... 18:40:17 INFO - Return code: 0 18:40:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:40:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bd3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a97a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c38840>, '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 0x2c39740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c39bd0>, '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': '438111f3d31ce799eff2119d000001bc-1496366126.471363-2005779219', '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 18:40:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:40:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:40:17 INFO - Using env: {'DISPLAY': ':0', 18:40:17 INFO - 'HOME': '/home/cltbld', 18:40:17 INFO - 'LANG': 'en_US.UTF-8', 18:40:17 INFO - 'LANGUAGE': 'en_US:en', 18:40:17 INFO - 'LOGNAME': 'cltbld', 18:40:17 INFO - 'MAIL': '/var/mail/cltbld', 18:40:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:17 INFO - 'MOZ_NO_REMOTE': '1', 18:40:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:17 INFO - 'NO_EM_RESTART': '1', 18:40:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:17 INFO - 'PWD': '/builds/slave/test', 18:40:17 INFO - 'SHELL': '/bin/bash', 18:40:17 INFO - 'SHLVL': '1', 18:40:17 INFO - 'TERM': 'linux', 18:40:17 INFO - 'TMOUT': '86400', 18:40:17 INFO - 'USER': 'cltbld', 18:40:17 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1496366126.471363-2005779219', 18:40:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:17 INFO - '_': '/tools/buildbot/bin/python'} 18:40:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:40:17 INFO - Running setup.py (path:/tmp/pip-R8y701-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:40:17 INFO - Running setup.py (path:/tmp/pip-zsxVEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:40:17 INFO - Running setup.py (path:/tmp/pip-LTPYCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:40:17 INFO - Running setup.py (path:/tmp/pip-yfbJKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:40:18 INFO - Running setup.py (path:/tmp/pip-ZbxTMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:40:18 INFO - Running setup.py (path:/tmp/pip-Y9_IwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:40:18 INFO - Running setup.py (path:/tmp/pip-JZTv_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:40:18 INFO - Running setup.py (path:/tmp/pip-JgqcPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:40:18 INFO - Running setup.py (path:/tmp/pip-dKcPsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:40:18 INFO - Running setup.py (path:/tmp/pip-QFvY1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:40:18 INFO - Running setup.py (path:/tmp/pip-Ey6RNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:40:18 INFO - Running setup.py (path:/tmp/pip-3UQLLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:40:18 INFO - Running setup.py (path:/tmp/pip-Ohe6bS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:40:18 INFO - Running setup.py (path:/tmp/pip-kG5B0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:40:18 INFO - Running setup.py (path:/tmp/pip-7L_Xgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:40:18 INFO - Running setup.py (path:/tmp/pip-G19Z8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:40:18 INFO - Running setup.py (path:/tmp/pip-sdAjFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:40:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:40:18 INFO - Running setup.py install for manifestparser 18:40:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:40:19 INFO - Running setup.py install for mozcrash 18:40:19 INFO - Running setup.py install for mozdebug 18:40:19 INFO - Running setup.py install for mozdevice 18:40:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:40:19 INFO - Running setup.py install for mozfile 18:40:19 INFO - Running setup.py install for mozhttpd 18:40:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:40:19 INFO - Running setup.py install for mozinfo 18:40:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:40:19 INFO - Running setup.py install for mozInstall 18:40:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:40:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:40:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:40:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:40:19 INFO - Running setup.py install for mozleak 18:40:19 INFO - Running setup.py install for mozlog 18:40:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:40:19 INFO - Running setup.py install for moznetwork 18:40:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:40:20 INFO - Running setup.py install for mozprocess 18:40:20 INFO - Running setup.py install for mozprofile 18:40:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:40:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:40:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:40:20 INFO - Running setup.py install for mozrunner 18:40:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:40:20 INFO - Running setup.py install for mozscreenshot 18:40:20 INFO - Running setup.py install for moztest 18:40:20 INFO - Running setup.py install for mozversion 18:40:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:40:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:40:20 INFO - Cleaning up... 18:40:20 INFO - Return code: 0 18:40:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:40:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:20 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 0x28bd3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a97a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c38840>, '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 0x2c39740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c39bd0>, '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': '438111f3d31ce799eff2119d000001bc-1496366126.471363-2005779219', '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 18:40:20 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 18:40:20 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 18:40:20 INFO - Using env: {'DISPLAY': ':0', 18:40:20 INFO - 'HOME': '/home/cltbld', 18:40:20 INFO - 'LANG': 'en_US.UTF-8', 18:40:20 INFO - 'LANGUAGE': 'en_US:en', 18:40:20 INFO - 'LOGNAME': 'cltbld', 18:40:20 INFO - 'MAIL': '/var/mail/cltbld', 18:40:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:20 INFO - 'MOZ_NO_REMOTE': '1', 18:40:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:20 INFO - 'NO_EM_RESTART': '1', 18:40:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:20 INFO - 'PWD': '/builds/slave/test', 18:40:20 INFO - 'SHELL': '/bin/bash', 18:40:20 INFO - 'SHLVL': '1', 18:40:20 INFO - 'TERM': 'linux', 18:40:20 INFO - 'TMOUT': '86400', 18:40:20 INFO - 'USER': 'cltbld', 18:40:20 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1496366126.471363-2005779219', 18:40:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:20 INFO - '_': '/tools/buildbot/bin/python'} 18:40:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:40:20 INFO - Running setup.py (path:/tmp/pip-q7v3Si-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:40:21 INFO - Running setup.py (path:/tmp/pip-mxsqcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:40:21 INFO - Running setup.py (path:/tmp/pip-gKynMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:40:21 INFO - Running setup.py (path:/tmp/pip-MJkffH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:40:21 INFO - Running setup.py (path:/tmp/pip-MBNUI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:40:21 INFO - Running setup.py (path:/tmp/pip-Q_Eii4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:40:21 INFO - Running setup.py (path:/tmp/pip-jplSMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:40:21 INFO - Running setup.py (path:/tmp/pip-CBcurO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:40:21 INFO - Running setup.py (path:/tmp/pip-ggM52e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:40:21 INFO - Running setup.py (path:/tmp/pip-US22qu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:40:21 INFO - Running setup.py (path:/tmp/pip-lWPYAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:40:21 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)) 18:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:40:21 INFO - Running setup.py (path:/tmp/pip-q01jXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:40:21 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)) 18:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:40:21 INFO - Running setup.py (path:/tmp/pip-iIsYO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:40:21 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)) 18:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:40:21 INFO - Running setup.py (path:/tmp/pip-aqL7MU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:40:21 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)) 18:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:40:21 INFO - Running setup.py (path:/tmp/pip-FmpVMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:40:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:40:22 INFO - Running setup.py (path:/tmp/pip-0OdVxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:40:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:40:22 INFO - Running setup.py (path:/tmp/pip-H1_jkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:40:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:40:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:40:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:40:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:40:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:40:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:40:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:23 INFO - Downloading blessings-1.6.tar.gz 18:40:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:40:23 INFO - Installing collected packages: blessings 18:40:23 INFO - Running setup.py install for blessings 18:40:23 INFO - Successfully installed blessings 18:40:23 INFO - Cleaning up... 18:40:23 INFO - Return code: 0 18:40:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:40:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:40:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:40:23 INFO - Reading from file tmpfile_stdout 18:40:23 INFO - Current package versions: 18:40:23 INFO - argparse == 1.2.1 18:40:23 INFO - blessings == 1.6 18:40:23 INFO - blobuploader == 1.2.4 18:40:23 INFO - docopt == 0.6.1 18:40:23 INFO - functools32 == 3.2.3-2 18:40:23 INFO - jsonschema == 2.5.1 18:40:23 INFO - manifestparser == 1.1 18:40:23 INFO - mozInstall == 1.12 18:40:23 INFO - mozcrash == 1.0 18:40:23 INFO - mozdebug == 0.1 18:40:23 INFO - mozdevice == 0.51 18:40:23 INFO - mozfile == 1.2 18:40:23 INFO - mozhttpd == 0.7 18:40:23 INFO - mozinfo == 0.9 18:40:23 INFO - mozleak == 0.1 18:40:23 INFO - mozlog == 3.4 18:40:23 INFO - moznetwork == 0.27 18:40:23 INFO - mozprocess == 0.25 18:40:23 INFO - mozprofile == 0.28 18:40:23 INFO - mozrunner == 6.13 18:40:23 INFO - mozscreenshot == 0.1 18:40:23 INFO - mozsystemmonitor == 0.3 18:40:23 INFO - moztest == 0.8 18:40:23 INFO - mozversion == 1.4 18:40:23 INFO - psutil == 3.1.1 18:40:23 INFO - requests == 1.2.3 18:40:23 INFO - wsgiref == 0.1.2 18:40:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:40:23 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')]} 18:40:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:23 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')]} 18:40:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:23 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 0x28bd3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a97a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c38840>, '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 0x2c39740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c39bd0>, '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': '438111f3d31ce799eff2119d000001bc-1496366126.471363-2005779219', '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 18:40:23 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 18:40:23 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 18:40:23 INFO - Using env: {'DISPLAY': ':0', 18:40:23 INFO - 'HOME': '/home/cltbld', 18:40:23 INFO - 'LANG': 'en_US.UTF-8', 18:40:23 INFO - 'LANGUAGE': 'en_US:en', 18:40:23 INFO - 'LOGNAME': 'cltbld', 18:40:23 INFO - 'MAIL': '/var/mail/cltbld', 18:40:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:23 INFO - 'MOZ_NO_REMOTE': '1', 18:40:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:23 INFO - 'NO_EM_RESTART': '1', 18:40:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:23 INFO - 'PWD': '/builds/slave/test', 18:40:23 INFO - 'SHELL': '/bin/bash', 18:40:23 INFO - 'SHLVL': '1', 18:40:23 INFO - 'TERM': 'linux', 18:40:23 INFO - 'TMOUT': '86400', 18:40:23 INFO - 'USER': 'cltbld', 18:40:23 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1496366126.471363-2005779219', 18:40:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:23 INFO - '_': '/tools/buildbot/bin/python'} 18:40:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:23 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)) 18:40:23 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)) 18:40:23 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)) 18:40:23 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)) 18:40:23 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)) 18:40:23 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)) 18:40:23 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)) 18:40:23 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)) 18:40:23 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)) 18:40:23 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:40:23 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 18:40:23 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 18:40:23 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 18:40:23 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 18:40:24 INFO - Downloading marionette_driver-1.4.0.tar.gz 18:40:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 18:40:25 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:40:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:40:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:40:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:40:25 INFO - Installing collected packages: marionette-driver 18:40:25 INFO - Running setup.py install for marionette-driver 18:40:25 INFO - Successfully installed marionette-driver 18:40:25 INFO - Cleaning up... 18:40:25 INFO - Return code: 0 18:40:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:40:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bd3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a97a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c38840>, '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 0x2c39740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c39bd0>, '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': '438111f3d31ce799eff2119d000001bc-1496366126.471363-2005779219', '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 18:40:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:40:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:40:25 INFO - Using env: {'DISPLAY': ':0', 18:40:25 INFO - 'HOME': '/home/cltbld', 18:40:25 INFO - 'LANG': 'en_US.UTF-8', 18:40:25 INFO - 'LANGUAGE': 'en_US:en', 18:40:25 INFO - 'LOGNAME': 'cltbld', 18:40:25 INFO - 'MAIL': '/var/mail/cltbld', 18:40:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:25 INFO - 'MOZ_NO_REMOTE': '1', 18:40:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:25 INFO - 'NO_EM_RESTART': '1', 18:40:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:25 INFO - 'PWD': '/builds/slave/test', 18:40:25 INFO - 'SHELL': '/bin/bash', 18:40:25 INFO - 'SHLVL': '1', 18:40:25 INFO - 'TERM': 'linux', 18:40:25 INFO - 'TMOUT': '86400', 18:40:25 INFO - 'USER': 'cltbld', 18:40:25 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1496366126.471363-2005779219', 18:40:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:25 INFO - '_': '/tools/buildbot/bin/python'} 18:40:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:40:25 INFO - Cleaning up... 18:40:25 INFO - Return code: 0 18:40:25 INFO - Running post-action listener: _resource_record_post_action 18:40:25 INFO - Running post-action listener: _start_resource_monitoring 18:40:25 INFO - Starting resource monitoring. 18:40:25 INFO - [mozharness: 2017-06-02 01:40:25.502668Z] Finished create-virtualenv step (success) 18:40:25 INFO - [mozharness: 2017-06-02 01:40:25.503183Z] Running install step. 18:40:25 INFO - Running pre-action listener: _resource_record_pre_action 18:40:25 INFO - Running main action method: install 18:40:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:40:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:40:25 INFO - Reading from file tmpfile_stdout 18:40:25 INFO - Detecting whether we're running mozinstall >=1.0... 18:40:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:40:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:40:25 INFO - Reading from file tmpfile_stdout 18:40:25 INFO - Output received: 18:40:25 INFO - Usage: mozinstall [options] installer 18:40:25 INFO - Options: 18:40:25 INFO - -h, --help show this help message and exit 18:40:25 INFO - -d DEST, --destination=DEST 18:40:25 INFO - Directory to install application into. [default: 18:40:25 INFO - "/builds/slave/test"] 18:40:25 INFO - --app=APP Application being installed. [default: firefox] 18:40:25 INFO - mkdir: /builds/slave/test/build/application 18:40:25 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'] 18:40:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:40:41 INFO - Reading from file tmpfile_stdout 18:40:41 INFO - Output received: 18:40:41 INFO - /builds/slave/test/build/application/firefox/firefox 18:40:41 INFO - Running post-action listener: _resource_record_post_action 18:40:41 INFO - [mozharness: 2017-06-02 01:40:41.868770Z] Finished install step (success) 18:40:41 INFO - [mozharness: 2017-06-02 01:40:41.869124Z] Running setup-mitmproxy step. 18:40:41 INFO - Running pre-action listener: _resource_record_pre_action 18:40:41 INFO - Running main action method: setup_mitmproxy 18:40:41 INFO - Skipping: mitmproxy is not required 18:40:41 INFO - Running post-action listener: _resource_record_post_action 18:40:41 INFO - [mozharness: 2017-06-02 01:40:41.870265Z] Finished setup-mitmproxy step (success) 18:40:41 INFO - [mozharness: 2017-06-02 01:40:41.870486Z] Running run-tests step. 18:40:41 INFO - Running pre-action listener: _resource_record_pre_action 18:40:41 INFO - Running main action method: run_tests 18:40:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:40:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:40:41 INFO - Python 2.7.3 18:40:41 INFO - Return code: 0 18:40:41 INFO - grabbing minidump binary from tooltool 18:40:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:41 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 0x2c38840>, '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 0x2c39740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c39bd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:40:41 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 18:40:41 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 18:40:41 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 18:40:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:40:41 INFO - Return code: 0 18:40:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:40:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:40:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:40:41 INFO - ENV: RUST_BACKTRACE is now 1 18:40:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:40:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:40:42 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/M01p551nRICde_z2WO7G_w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-086', '--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 18:40:42 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/M01p551nRICde_z2WO7G_w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-086 --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 18:40:42 INFO - Using env: {'DISPLAY': ':0', 18:40:42 INFO - 'HOME': '/home/cltbld', 18:40:42 INFO - 'LANG': 'en_US.UTF-8', 18:40:42 INFO - 'LANGUAGE': 'en_US:en', 18:40:42 INFO - 'LOGNAME': 'cltbld', 18:40:42 INFO - 'MAIL': '/var/mail/cltbld', 18:40:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:40:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:40:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:42 INFO - 'MOZ_NO_REMOTE': '1', 18:40:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:40:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:42 INFO - 'NO_EM_RESTART': '1', 18:40:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:42 INFO - 'PWD': '/builds/slave/test', 18:40:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:40:42 INFO - 'RUST_BACKTRACE': '1', 18:40:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:40:42 INFO - 'SHELL': '/bin/bash', 18:40:42 INFO - 'SHLVL': '1', 18:40:42 INFO - 'TERM': 'linux', 18:40:42 INFO - 'TMOUT': '86400', 18:40:42 INFO - 'USER': 'cltbld', 18:40:42 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1496366126.471363-2005779219', 18:40:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:42 INFO - '_': '/tools/buildbot/bin/python'} 18:40:42 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/M01p551nRICde_z2WO7G_w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-086', '--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 18:40:42 INFO - mozversion application_buildid: 20170602010042 18:40:42 INFO - mozversion application_changeset: 877c3da58fa35bf4e58f2ac0cbcf59840702cc6e 18:40:42 INFO - mozversion application_display_name: Nightly 18:40:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:40:42 INFO - mozversion application_name: Firefox 18:40:42 INFO - mozversion application_remotingname: firefox 18:40:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:40:42 INFO - mozversion application_vendor: Mozilla 18:40:42 INFO - mozversion application_version: 55.0a1 18:40:42 INFO - mozversion platform_buildid: 20170602010042 18:40:42 INFO - mozversion platform_changeset: 877c3da58fa35bf4e58f2ac0cbcf59840702cc6e 18:40:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:40:42 INFO - mozversion platform_version: 55.0a1 18:40:42 INFO - using testdate: 1496367642 18:40:42 INFO - actual date: 1496367642 18:40:42 INFO - starting webserver on 'localhost:43651' 18:40:42 INFO - SUITE-START | Running 2 tests 18:40:42 INFO - TEST-START | dromaeo_css 18:40:42 INFO - operating with platform_type : linux_ 18:40:42 INFO - Initialising browser for dromaeo_css test... 18:40:42 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43651/getInfo.html -profile /tmp/tmp8yhFbJ/profile 18:40:42 INFO - TEST-INFO | started process 19651 (/builds/slave/test/build/application/firefox/firefox http://localhost:43651/getInfo.html) 18:41:17 INFO - TEST-INFO | 19651: killed by SIGTERM 18:41:17 INFO - Browser initialized. 18:41:17 INFO - Running cycle 1/1 for dromaeo_css test... 18:41:17 INFO - TEST-INFO | started process 19880 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8yhFbJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:41:29 INFO - PID 19880 | RSS: Main: 188203008 18:41:29 INFO - PID 19880 | 18:44:33 INFO - PID 19880 | Cycle 1(1): loaded http://localhost:43651/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43651/tests/dromaeo/cssquery-ext.html) 18:44:35 INFO - PID 19880 | RSS: Main: 181907456 18:44:35 INFO - PID 19880 | 18:47:37 INFO - PID 19880 | Cycle 1(1): loaded http://localhost:43651/tests/dromaeo/cssquery-ext.html (next: http://localhost:43651/tests/dromaeo/cssquery-jquery.html) 18:47:38 INFO - PID 19880 | RSS: Main: 189329408 18:47:38 INFO - PID 19880 | 18:50:39 INFO - PID 19880 | Cycle 1(1): loaded http://localhost:43651/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43651/tests/dromaeo/cssquery-mootools.html) 18:50:40 INFO - PID 19880 | RSS: Main: 186445824 18:50:40 INFO - PID 19880 | 18:53:42 INFO - PID 19880 | Cycle 1(1): loaded http://localhost:43651/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43651/tests/dromaeo/cssquery-prototype.html) 18:53:43 INFO - PID 19880 | RSS: Main: 190672896 18:53:43 INFO - PID 19880 | 18:56:46 INFO - PID 19880 | Cycle 1(1): loaded http://localhost:43651/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43651/tests/dromaeo/cssquery-yui.html) 18:56:46 INFO - PID 19880 | RSS: Main: 188956672 18:56:46 INFO - PID 19880 | 18:59:48 INFO - PID 19880 | Cycle 1(1): loaded http://localhost:43651/tests/dromaeo/cssquery-yui.html (next: http://localhost:43651/tests/dromaeo/cssquery-dojo.html) 18:59:48 INFO - PID 19880 | RSS: Main: 186580992 18:59:48 INFO - PID 19880 | 18:59:48 INFO - PID 19880 | __start_tp_report 18:59:48 INFO - PID 19880 | _x_x_mozilla_page_load 18:59:48 INFO - PID 19880 | _x_x_mozilla_page_load_details 18:59:48 INFO - PID 19880 | |i|pagename|runs| 18:59:48 INFO - PID 19880 | |0;dojo.html;2672.016688875248;2710.4850078485097;2731.085086496024;2747.2307753828927;2749.615053892454;5095.643304968654;5202.0376230397305;5244.816431424901;5256.106461901476;5279.234510995908;5143.81996630118;5186.507281808232;5218;5287.86780330491;5310.8406747797535;4664.3936288282475;4688.273317635755;4689.413823272091;4704.1062198182235;4745.240761478164;4689.812407503713;4695.037517308961;4752.120857641347;4777.546133117366;4819.903601927959;4540.341650460665;4577.176108300505;4678.578927896471;4687.484376718558;4737.549932756383;4639.628829693616;4658.604018658418;4706.599939005188;4708.529147085298;4729.668923175379;4645.187092258841;4645.721256724607;4657.930131048037;4662.114198302312;4701.835435759732;5191.351081114861;5242.580593552507;5249.212618107276;5258.1849813279005;5270.525652691276;5521.503064724194;5605.831825045255;5606.691631960241;5683;5696.886062278772;5746.224259724967;5746.913796293059;5750.453706897838;5780.624259423124;5804.477597016289;5343.812966546191;5347.705876176848;5348.277982472394;5350.277712508761;5351.1973204019705;5695.430456954271;5753.913691294634;5773.191753154561;5886.705664716747;5886.970565147147;5525.613207075547;5576.191452239484;5589.413111623302;5613.46672066153;5628.04323265046;5621.747021384048;5645.887082258332;5656.236408084856;5669.121286200645;5677.233573467612;5493.23094766733;5522.696251706195;5623.915641265385;5626.381098079208;5647;5483.862903427446;5542.612017158841;5550.833474995757;5557.916631250535;5571.777128914879;4850.805967761321;4875.463698993108;4876.683015603974;4878.707277563358;4922.778474968635;4130.710850240454;4145.233131870553;4151.14901445203;4162.334026555736;4203.789810509462;4687.273472611751;4743.312219728189;4750.097481478508;4780.402449693788;4799.256115302133;5664.575156863251;5665.886682266331;5675.347335056521;5676.574256930747;5710.743016564182;4763.499832517605;4765.69023013503;4777.283407488835;4783.928241076386;4814.759262036954;4922.803087876517;4992.301077849104;5011.1481048221885;5024.321716568216;5037.068142393596;5237.659552129099;5285.63000589955;5286.788528458972;5289.41816400188;5297.470252974672;5485.807996720096;5566.860828479321;5637.069883469182;5657.660540367591;5684.63049901755;5207.505286997729;5223.608229382888;5305.575553955751;5328.387235467816;5339.626226164287;5454.618176727591;5545.584081193846;5554.777808887599;5567.638103523258;5583.916241256303;5562.443755624567;5638.633488823213;5660.037793575019;5734.3692193857805;5766.826995190151;5472.370677372153;5519.144532597294;5527.695976721319;5528.502434780889;5574.86062848432;5519.2824932758485;5520.1167813151305;5523.530499907392;5528.44715528444;5536.861578460571;5259.237410575522;5330.493603107699;5409.594280429063;5432.158015507603;5437.945620543744;5586.469285417878;5605.803796867253;5608.6073974823;5642.717864106696;5643.802466913638;5413.458654134555;5424.511793938565;5437.592180586393;5437.619366644297;5444.373897001737 18:59:48 INFO - PID 19880 | |1;ext.html;712.1454254894128;741.162486390379;760.9429292803039;954.2890546542826;963.5037955452939;30222.395552088947;30698;30815.22961925953;30860.845695771546;31096.689033109662;31857.362852742932;32155.678443215562;32163.67836321636;32224.355512889728;32305.67694323056;6437.549371543993;6620.073189753439;6850.486213533993;6971.721131154748;6987.82530436738;6600.570962887397;6684.632345221011;6701.832454188636;6711.5301928865;6713;6660.100886380349;6700.731970721165;6713.26154123046;6713.56361836479;6717.630530320855;6587.308332625077;6645.501587380917;6689.163854518185;6689.397954184123;6695.062691223233;6585.80242592723;6615.867682646368;6631.171103612049;6631.767888123893;6632.602043877383;30773;31002.37995240105;31044.53433198504;31351.529727054112;31636.525452118236;2687.314734742628;2714.4978179036943;2715.4297597504547;2717.1033558925506;2723.060544112278;23660.64509032366;23667;23712.64431033536;23714.881425592936;24089.156879509133;2690.394661201214;2727.290904364879;2729.4541091781525;2731.549294366447;2732.303262668027;122075;122969;130745;139972;141025;37729.245415091544;37931.81034094812;38451.42322865159;38524.8073759635;38599.228015440094;39377.40933885994;40193;40312.39531407031;40350;40437.39343909785;11146.721331966604;11285.322880627189;11290.943545282222;11294.54821807135;11317.773644527064;8868.33487488441;8880.777980550409;8886.066962968924;8894.555272236492;8900.287976961827;12047.759044819055;12187.268763874195;12256.406667133215;12265.632031039084;12396.938015310046;5124.487551244845;5322.2548843161985;5350.224217488442;5360.169173777993;5417.4311697272005;770.8843673448915;804.9114597394282;808.3654331349862;808.890799742039;822.9711960081369;18146.546336341435;18490.167942442622;18516.537086572942;18680.53298667544;19508.12213450398;846.1200351634232;857.1771099744191;871.9433236839585;874.6894852327459;882.8057827277988;9755.170810481046;9882.407055576688;10174.694759157237;10176.898231017594;10282.897171028344;169303.15348423427;169607.1519642394;169665;170026;170196.32153337944;32604;32610.510842337382;32683.346333073205;32769;32895.506567401506;1101.2291396022815;1130.745582244005;1179.6991767099507;1193.2124797633694;1211.3943028485758;18778.12218778111;19692.40922772319;20251.79748202499;20392.694109588072;20429.182832686525;28371.148865534065;28430.289242769097;28585;28623;28760.424791504473;146119;147181;147617;148165.25917370344;148356;20767.896160519704;20912.1635134599;24412;24824;25068.62397064082;29307.70692293135;29672;29899.850500747358;29929.850350748107;30202.54696179515;23204.419889502897;23291.3012609622;23390.883045585342;23875.880620596785;23946.76053239515;22404.439889002904;23165.536689266457;23313.76686233116;23421.531569368857;23900.28299151028;25487.36281592975;29410.11769646914;29823.850880745456;31038;31223.375532489677;26480.867595661897;26539.469210616066;26543.7345626549;26974.32564185911;27312;19391.3213037543;21326;21392.544901050132;21418.250361237282;21665.35003949884 18:59:48 INFO - PID 19880 | |2;jquery.html;405.6957282038471;406.54670042902154;413.6947929283113;427.7540414261799;427.916556271527;17462;17994.460166195004;18031.81968180318;18077.548061298443;18792.812071879278;19216.135273912674;19752.111154998023;19833.305834295803;19852.50368740782;19890.900545497254;5609.298837645294;5723.4848863602265;5733.971330143343;5735.741891614887;5769.538436925036;5711.514521265697;5731.340895796974;5755.82732518023;5758.654480731148;5777.884442311151;5124.436312005695;5657.575681823859;5720.9713951430185;5728.255326807509;5757.913631295534;5150.227465880129;5192.7144007079405;5204.583633309327;5225.712585807779;5248.239005344223;4711.505291944365;4750.239961606127;4767.165745994437;4773.260144677581;4790.329353890458;22827.77172228273;23350.299491015296;23359.532809343887;23381.41546461335;23465.648015279785;1647.5139833748954;1676.773635559196;1681.697294486992;1682.730763077914;1685.5112017514905;15538.61153471161;15775.92112039444;15820.76268855968;15885.126318052502;15889.761653575206;2099.4331530486834;2112.5141217519904;2135.124598914453;2152.182170775111;2168.642174041281;104379;105125;105265;110212;111170;11052;11356.54573817038;11381.601643942422;11628.88371116278;11748.236364636272;15899.125548094966;16028.358865645478;16068.598285042968;16075.758863617055;16105.436309729103;7144.8928266076055;7277.490575659759;7316.414686825041;7562.243775622504;7572.962135189399;6693.196816382066;6778.457723382117;6819.488538359643;6850.588964662136;6852.9783713804545;7331.193568707438;7347.853042939111;7368.410527157815;7489.251074892467;7522.285382888617;1953.2870502266571;1971.132002935725;1974.9111289991986;2008.6886532587473;2225.3880182949492;800.3157300507982;830.9293710034594;832.8459235041537;840.5167028958373;844.0926004545139;17107.65784684324;17388.565285867953;17629.55926101832;18097.36659216921;18372.173252203684;822.9218224268685;823.6828820903995;824.1099612418574;832.675256649907;844.3709436469869;9331.16019558243;9426.481543515172;9696.854547181798;9767.51162441875;9972.750681233027;359282;364380;403688;406325;417066;90566.54716726506;93547;93555.53222233846;94339;95400;833.295864994079;868.2402897464718;1005.5676059294574;1008.1128606825946;1051.584624073502;17168.570785730455;17436.564085897448;18192.909035454737;18615.627687446446;18794.15426305847;46287.12252620564;47359;47537.5246247547;47826;47972.7601361991;58857.70571147288;59045.409545905706;59050.40949590621;59145.70427148009;59315.406845930986;13473;13647.317634118055;13649.931750341184;13771;13829.170249785046;15430;15449.382024718885;15474.226288685746;15487.922560387577;15687.137207453243;12488.25070495773;13086.476540938636;13090.541831035867;13103.344832758134;13173.341332933507;11811.468483918416;11878.287302761863;11894.583689570823;12046;12593.118481706193;13172.209667419602;13746.450141994608;13765.38055787472;13781.104228225133;13798;13656.453741850612;13831.308434578432;13875.514356997457;13961.232132232824;13986.790198147239;12928.353582321035;12953.158044727063;13084.149530280501;13131.803022954855;13208.27354495512 18:59:48 INFO - PID 19880 | |3;mootools.html;1204.8855358740918;1248.9625311240661;1257.0320852943228;1268.632096691959;1272.1985149355905;9227.492487913161;9431;9449.574769135388;9862.063104005127;9871.605135794569;8694.304455643549;8745.125487451252;8803.295736341093;8830.91169088309;8859.335549833757;2027.6147531968916;2063.401613532074;2065.8760474371584;2072.347210628647;2074.3776866939934;1846.0677357934223;1888.8205620466033;1892.1201641236821;1892.6593213221615;1899.1074195128267;2010.6280338137492;2043.3052762060897;2054.1783286685295;2054.4966483211633;2056.0542150610736;1970.2217624038497;1977.0707767349322;1979.0302751651732;1982.0684278389206;1983.4148926066846;1940.4469726128127;1941.262320318284;1982.9206831726713;2055.98972005139;2063.7110804487384;9692.22462203022;9772.169365603932;9794.16749576287;9835.557399917021;9868.95065524675;5046.772895219724;5240.109181439165;5253.106971814801;5257.0274499217385;5265.6840589564745;3046.329807442359;3175.126840118986;3210.2295449092285;3221.3396253768155;3225.758068144875;967.685502211784;976.9804603907882;1000.3697670467559;1002.6440613582146;1004.1063453526367;12841.486340546368;13213.141145825586;14556.272186390745;14691.55925322242;14724;4307.849225277163;4408.58118478744;4416.337549367557;4434.379186913835;4467.865964021084;10425.843612345821;10480.056794888496;10522.473876306154;10524.36853788775;10545.47272636365;5074.797008119708;5076.974615126901;5082.466341034212;5091.490850914879;5098.847034588968;4678.157931572282;4691.483936766953;4700.506446823103;4820.9517904821205;4826.1795494765975;3680.4847321375028;3797.2974999625158;3827.61723827615;3851.9229615407535;3858.749181303206;1119.361963680694;1130.6887779138785;1134.495149658394;1135.982960255597;1136.5056200552785;607.5564837668527;628.9402357028331;632.3170975346615;633.2053273142177;634.4702173685025;4851.975740121276;4896.853094407174;4903.95096049035;4909.091818013679;4967.379077615298;511.2357026245712;528.0336983320515;529.499622856397;530.2152813835545;530.8327876718821;3094.1491089950446;3293.884714034997;3305.272839975202;3314.320564284316;3371.3762953853616;11887;12661.36693165338;12674.36628168588;12740.108192426627;12770.106092573616;11341.603043893589;11484;11491.77016459666;11519.769604607862;11544.249623774596;5881.294244690579;5947.434993675594;5992.13114098462;6009.128676341993;6061.393860613992;4908.7545622719435;5155.587552995827;5168.870778230424;5297.470252974672;5349.732513374238;11332.206745527734;11429;11507.94246028798;11556.59551915679;11627.941860290644;10788.460576970963;11725.589604363806;11829.231099978473;11877.406129693654;12043.458044388199;6843.657817109224;7016.193137789015;7026.859462810818;7098.219195888345;7134.393576546052;8592.914070859211;8751.562421879007;8754;8782.385233033627;8782.780430489289;7158.141023077264;7506.924930750841;7678.5392876427595;7739.071311442663;7821.100573434128;7004.544704594185;7068.151821781419;7114.608696521534;7145.249748776304;7210.134783825974;6311.116443697794;6316.684165791784;6396.456301214263;6412.871742565216;6422.454091402283;4564.475085365093;4583.6562257831465;4665.183592871302;4689.929651055305;4841.298011788201;4884.169691152583;4908.288298196813;4943.77753001123;4981.227909673861;5101.7194054327365 18:59:48 INFO - PID 19880 | |4;prototype.html;344.5348779148149;344.7052769881753;346.2520954737766;348.1974049815175;351.8557391469498;5627.409122042188;5643.435656434354;5655.886882262353;5665.405132461089;5677.48902598766;5459.816073570574;5469.179623056533;5472.2338872557875;5472.34331880174;5472.398036216013;3995.22093191827;4105.9178816423655;4106.691998100139;4113.403556484308;4122.670186385097;4115.8971025724295;4120.855770048049;4132.876013719593;4137.420761093449;4142.399352093945;4079.9796001019954;4081.979590102045;4084.264832330179;4086.4687590613325;4086.9591304087025;4085.22380747657;4090.325096359097;4091.4476545666403;4101.405296232029;4101.630853223194;3597.6328994982;3602.6397360264027;3605.4856960076568;3608.981955090234;3612.6026137124895;5378.327709036371;5411.134218525057;5420.810271640513;5421.674699518042;5452.182172674091;4829.251466022737;4834.830780922686;4836.637252206064;4840.128776820171;4841.878953026203;5840.474357307863;5845.912311315334;5854.18041474194;5856.941430585724;5872.941270587282;4033.6773058155277;4043.5349934757587;4047.4535937648334;4055.1078762672164;4055.1281474482835;5800.622959507618;6132.754689812402;6150.907736384002;6195.163652906845;6197.690115494207;4014.979925100356;4041.3533834586915;4054.9391759123637;4057.5739547347694;4061.5329237138108;4091.161311931047;4101.733387329814;4109.691773117028;4111.157212771374;4112.856050038235;4633.536646335407;4757.405324334458;4758.5241475852135;4761.761911904391;4787.40157480315;5820.679862607512;5841.970790146022;5857.15071314657;5870.26621672291;5873.949831673298;1426.657602175491;1428.9714205715827;1429.9765831348734;1432.777919422491;1436.5115860607443;934.2245935873344;952.4333021851987;976.4043933200742;980.4117529482396;982.415462799633;5013.323201367842;5023.472535383805;5043.9747801260755;5047.621428392885;5047.798088076436;5976.163337132805;5985.221921150222;6008.279006519246;6010.459058684739;6018.638881667114;4972.453030166679;4980.452150263468;4990.6506544541535;4992.750362481861;4993.1262029144755;3155.5266709993684;3177.650458449615;3187.7131058204873;3200.919977000547;3203.9839800800846;5536.141898005815;5591.7483713233005;5594;5601.831945041656;5603.523700485504;6155.96922015396;6175.714985455321;6199.194104766351;6205.689715514206;6205.906911396332;5520.91718624221;5550.47270509301;5551;5552.7778888843995;5553.333599968029;5983.132445795422;5987.371326010706;5994.100884867305;5996.520278377632;6007.4893634039845;5907.32065812437;5922.141289512911;5929.436703513159;5938.673372964356;5950.434708702666;5335.1730481775385;5399.4060653327315;5465.890682186414;5533.363663178786;5541.141123125922;4025.315696331689;4029.9597004029583;4031.496062992126;4050.3924411338535;4051.8379264829077;6031.577789554689;6043.969780151247;6044.7279872406725;6050.45545900871;6058.7273572688455;5663.677892064234;5848.298204215351;5869.266341707286;5886.793962211302;5888.205092312483;5828.854278643068;5830.82507524775;5843.386444423274;5868.501177399969;5872.500837428866;5755.5683323750045;5757.884842303214;5761.193432919311;5776.537876969916;5790;5897.997340452219;5901.557383196363;5905.40945905406;5909.349971503218;5936.465718085393;5694.576355911022;5711.971440142773;5721.628094173865;5730.111832665943;5773.364929857797 18:59:48 INFO - PID 19880 | |5;yui.html;578.2800413485212;582.5000623394759;648.9383508566686;667.7128834601119;670.664667666167;11650.533978640855;11952.7609447811;12086.758264834709;15049.849501504981;16061.437849675234;14449.711005779878;14568.708625827478;14629.975901686887;14638.194899280536;14684.486042988498;798.8402319536101;809.7368355284526;810.6514198894473;813.4509206285763;818.8075802186481;783.6356094416095;804.5454318310166;809.9230573095576;815.8449894520052;816.1675091406792;859.9570021498931;860.1312674199073;861.5649097205902;862.0259107208846;862.3833958719514;849.8725191221366;856.6530555125184;858.1804376820153;859.4027151129967;861.8922634670666;607.3774381259201;622.8785386849567;626.9059641053833;627.6077451592755;630.180765005491;13696.65758356049;13853.376598053112;13859.653508662263;13884.51404200848;13903.513377031755;12458.563950261789;13399;13412;13438.798418023738;13442.193468391928;11010.834837477445;11156.721081972935;11229.60696375631;11249.325040497515;11295.378754168518;2966.9406611867644;2968;2982.746466550324;2990.5514172874027;3005.6844031376827;76938.3051796453;79035.60482197552;79213;79851;80213;10976.341419514854;11469.426528673534;11500.94249528747;11501;11594.76810463786;14962.775558366633;15459.92270038665;19445.90277048634;20080.799192007893;20456.590868182553;5952.464278214895;6104.603200791934;6120.387961203844;6121.204243448323;6139.84650383744;2890.1762997545597;2912.271932016996;2948.4250571138423;2948.9852550737537;2959.6596391414832;3719.1631882826687;3787.5454945406177;3823.636754508317;3851.268259030775;3851.7111216658864;664.3124366280877;674.0798809624827;675.598019178588;676.0197713315712;679.2765704524666;497.76107468415364;506.4150905703918;506.7035784066289;509.81391791995657;513.9614528910347;10251.743706407251;10401.115905148146;10464.52909619069;10853.782924341469;11133.610323638633;435.2426777407289;447.60834270013737;449.0188937172289;505.8794769585386;513.5609054258555;4223.72545784523;4307.892302692395;4345.000649850489;4373.300271956472;4375.78121093944;73762;76588;77762.61118694484;80870.59564702139;80894.19105808984;64981;65320;65514.67242663756;67619.66190169018;67858.66070669713;59418.405815942155;61143.38856611377;61384;62051;62222.377776221656;8320.791980200544;8426.95786521088;8442.197991190827;8459.534725590152;8522.105178956368;26489.602655959792;26976.595351069358;27017;27030;28058;33440.49839252462;59570;60321.396786031575;60386.69806650939;60951.39048609457;13596.728065438438;13762.449502019806;13887;13900.721985560434;14447.060941038799;14936.477223297132;15148.848511514743;15476.993995390263;15665.138417387154;15827.683446331239;13265.867341326462;13326.200427973965;13353.933230334174;13443.193408395528;13639.181649101085;14063.789043164565;14117.647058823612;14226.50207242783;14320.427182912566;14432.711345773236;14618.488352907598;14915.627109322353;15124.319405626553;15282;15432.537023889301;8582.828343432971;8720.563971801512;9150.176484116462;9282.257419406296;9309.86035209486;10602.25784195099;10855.891441085803;10979.670609881716;11011.61459348919;11374.886251137383 18:59:48 INFO - PID 19880 | __end_tp_report 18:59:48 INFO - PID 19880 | __start_cc_report 18:59:48 INFO - PID 19880 | _x_x_mozilla_cycle_collect,400 18:59:48 INFO - PID 19880 | __end_cc_report 18:59:48 INFO - PID 19880 | __startTimestamp1496368788914__endTimestamp 18:59:48 INFO - PID 19880 | 18:59:48 INFO - PID 19880 | ------- Summary: start ------- 18:59:48 INFO - PID 19880 | Number of tests: 6 18:59:48 INFO - PID 19880 | 18:59:48 INFO - PID 19880 | [#0] dojo.html Cycles:165 Average:5177.36 Median:5343.81 stddev:600.41 (11.2%) stddev-sans-first:569.18 18:59:48 INFO - PID 19880 | Values: 2672.0 2710.5 2731.1 2747.2 2749.6 5095.6 5202.0 5244.8 5256.1 5279.2 5143.8 5186.5 5218.0 5287.9 5310.8 4664.4 4688.3 4689.4 4704.1 4745.2 4689.8 4695.0 4752.1 4777.5 4819.9 4540.3 4577.2 4678.6 4687.5 4737.5 4639.6 4658.6 4706.6 4708.5 4729.7 4645.2 4645.7 4657.9 4662.1 4701.8 5191.4 5242.6 5249.2 5258.2 5270.5 5521.5 5605.8 5606.7 5683.0 5696.9 5746.2 5746.9 5750.5 5780.6 5804.5 5343.8 5347.7 5348.3 5350.3 5351.2 5695.4 5753.9 5773.2 5886.7 5887.0 5525.6 5576.2 5589.4 5613.5 5628.0 5621.7 5645.9 5656.2 5669.1 5677.2 5493.2 5522.7 5623.9 5626.4 5647.0 5483.9 5542.6 5550.8 5557.9 5571.8 4850.8 4875.5 4876.7 4878.7 4922.8 4130.7 4145.2 4151.1 4162.3 4203.8 4687.3 4743.3 4750.1 4780.4 4799.3 5664.6 5665.9 5675.3 5676.6 5710.7 4763.5 4765.7 4777.3 4783.9 4814.8 4922.8 4992.3 5011.1 5024.3 5037.1 5237.7 5285.6 5286.8 5289.4 5297.5 5485.8 5566.9 5637.1 5657.7 5684.6 5207.5 5223.6 5305.6 5328.4 5339.6 5454.6 5545.6 5554.8 5567.6 5583.9 5562.4 5638.6 5660.0 5734.4 5766.8 5472.4 5519.1 5527.7 5528.5 5574.9 5519.3 5520.1 5523.5 5528.4 5536.9 5259.2 5330.5 5409.6 5432.2 5437.9 5586.5 5605.8 5608.6 5642.7 5643.8 5413.5 5424.5 5437.6 5437.6 5444.4 18:59:48 INFO - PID 19880 | 18:59:48 INFO - PID 19880 | [#1] ext.html Cycles:180 Average:28108.65 Median:29541.06 stddev:38818.77 (131.4%) stddev-sans-first:38873.15 18:59:48 INFO - PID 19880 | Values: 712.1 741.2 760.9 954.3 963.5 30222.4 30698.0 30815.2 30860.8 31096.7 31857.4 32155.7 32163.7 32224.4 32305.7 6437.5 6620.1 6850.5 6971.7 6987.8 6600.6 6684.6 6701.8 6711.5 6713.0 6660.1 6700.7 6713.3 6713.6 6717.6 6587.3 6645.5 6689.2 6689.4 6695.1 6585.8 6615.9 6631.2 6631.8 6632.6 30773.0 31002.4 31044.5 31351.5 31636.5 2687.3 2714.5 2715.4 2717.1 2723.1 23660.6 23667.0 23712.6 23714.9 24089.2 2690.4 2727.3 2729.5 2731.5 2732.3 122075.0 122969.0 130745.0 139972.0 141025.0 37729.2 37931.8 38451.4 38524.8 38599.2 39377.4 40193.0 40312.4 40350.0 40437.4 11146.7 11285.3 11290.9 11294.5 11317.8 8868.3 8880.8 8886.1 8894.6 8900.3 12047.8 12187.3 12256.4 12265.6 12396.9 5124.5 5322.3 5350.2 5360.2 5417.4 770.9 804.9 808.4 808.9 823.0 18146.5 18490.2 18516.5 18680.5 19508.1 846.1 857.2 871.9 874.7 882.8 9755.2 9882.4 10174.7 10176.9 10282.9 169303.2 169607.2 169665.0 170026.0 170196.3 32604.0 32610.5 32683.3 32769.0 32895.5 1101.2 1130.7 1179.7 1193.2 1211.4 18778.1 19692.4 20251.8 20392.7 20429.2 28371.1 28430.3 28585.0 28623.0 28760.4 146119.0 147181.0 147617.0 148165.3 148356.0 20767.9 20912.2 24412.0 24824.0 25068.6 29307.7 29672.0 29899.9 29929.9 30202.5 23204.4 23291.3 23390.9 23875.9 23946.8 22404.4 23165.5 23313.8 23421.5 23900.3 25487.4 29410.1 29823.9 31038.0 31223.4 26480.9 26539.5 26543.7 26974.3 27312.0 19391.3 21326.0 21392.5 21418.3 21665.4 18:59:48 INFO - PID 19880 | 18:59:48 INFO - PID 19880 | [#2] jquery.html Cycles:180 Average:27758.56 Median:2160.41 stddev:65853.47 (3048.2%) stddev-sans-first:66006.18 18:59:48 INFO - PID 19880 | Values: 405.7 406.5 413.7 427.8 427.9 17462.0 17994.5 18031.8 18077.5 18792.8 19216.1 19752.1 19833.3 19852.5 19890.9 5609.3 5723.5 5734.0 5735.7 5769.5 5711.5 5731.3 5755.8 5758.7 5777.9 5124.4 5657.6 5721.0 5728.3 5757.9 5150.2 5192.7 5204.6 5225.7 5248.2 4711.5 4750.2 4767.2 4773.3 4790.3 22827.8 23350.3 23359.5 23381.4 23465.6 1647.5 1676.8 1681.7 1682.7 1685.5 15538.6 15775.9 15820.8 15885.1 15889.8 2099.4 2112.5 2135.1 2152.2 2168.6 104379.0 105125.0 105265.0 110212.0 111170.0 11052.0 11356.5 11381.6 11628.9 11748.2 15899.1 16028.4 16068.6 16075.8 16105.4 7144.9 7277.5 7316.4 7562.2 7573.0 6693.2 6778.5 6819.5 6850.6 6853.0 7331.2 7347.9 7368.4 7489.3 7522.3 1953.3 1971.1 1974.9 2008.7 2225.4 800.3 830.9 832.8 840.5 844.1 17107.7 17388.6 17629.6 18097.4 18372.2 822.9 823.7 824.1 832.7 844.4 9331.2 9426.5 9696.9 9767.5 9972.8 359282.0 364380.0 403688.0 406325.0 417066.0 90566.5 93547.0 93555.5 94339.0 95400.0 833.3 868.2 1005.6 1008.1 1051.6 17168.6 17436.6 18192.9 18615.6 18794.2 46287.1 47359.0 47537.5 47826.0 47972.8 58857.7 59045.4 59050.4 59145.7 59315.4 13473.0 13647.3 13649.9 13771.0 13829.2 15430.0 15449.4 15474.2 15487.9 15687.1 12488.3 13086.5 13090.5 13103.3 13173.3 11811.5 11878.3 11894.6 12046.0 12593.1 13172.2 13746.5 13765.4 13781.1 13798.0 13656.5 13831.3 13875.5 13961.2 13986.8 12928.4 12953.2 13084.1 13131.8 13208.3 18:59:48 INFO - PID 19880 | 18:59:48 INFO - PID 19880 | [#3] mootools.html Cycles:180 Average:5736.70 Median:4671.67 stddev:3760.58 (80.5%) stddev-sans-first:3755.71 18:59:48 INFO - PID 19880 | Values: 1204.9 1249.0 1257.0 1268.6 1272.2 9227.5 9431.0 9449.6 9862.1 9871.6 8694.3 8745.1 8803.3 8830.9 8859.3 2027.6 2063.4 2065.9 2072.3 2074.4 1846.1 1888.8 1892.1 1892.7 1899.1 2010.6 2043.3 2054.2 2054.5 2056.1 1970.2 1977.1 1979.0 1982.1 1983.4 1940.4 1941.3 1982.9 2056.0 2063.7 9692.2 9772.2 9794.2 9835.6 9869.0 5046.8 5240.1 5253.1 5257.0 5265.7 3046.3 3175.1 3210.2 3221.3 3225.8 967.7 977.0 1000.4 1002.6 1004.1 12841.5 13213.1 14556.3 14691.6 14724.0 4307.8 4408.6 4416.3 4434.4 4467.9 10425.8 10480.1 10522.5 10524.4 10545.5 5074.8 5077.0 5082.5 5091.5 5098.8 4678.2 4691.5 4700.5 4821.0 4826.2 3680.5 3797.3 3827.6 3851.9 3858.7 1119.4 1130.7 1134.5 1136.0 1136.5 607.6 628.9 632.3 633.2 634.5 4852.0 4896.9 4904.0 4909.1 4967.4 511.2 528.0 529.5 530.2 530.8 3094.1 3293.9 3305.3 3314.3 3371.4 11887.0 12661.4 12674.4 12740.1 12770.1 11341.6 11484.0 11491.8 11519.8 11544.2 5881.3 5947.4 5992.1 6009.1 6061.4 4908.8 5155.6 5168.9 5297.5 5349.7 11332.2 11429.0 11507.9 11556.6 11627.9 10788.5 11725.6 11829.2 11877.4 12043.5 6843.7 7016.2 7026.9 7098.2 7134.4 8592.9 8751.6 8754.0 8782.4 8782.8 7158.1 7506.9 7678.5 7739.1 7821.1 7004.5 7068.2 7114.6 7145.2 7210.1 6311.1 6316.7 6396.5 6412.9 6422.5 4564.5 4583.7 4665.2 4689.9 4841.3 4884.2 4908.3 4943.8 4981.2 5101.7 18:59:48 INFO - PID 19880 | 18:59:48 INFO - PID 19880 | [#4] prototype.html Cycles:180 Average:4775.96 Median:5472.29 stddev:1438.44 (26.3%) stddev-sans-first:1403.50 18:59:48 INFO - PID 19880 | Values: 344.5 344.7 346.3 348.2 351.9 5627.4 5643.4 5655.9 5665.4 5677.5 5459.8 5469.2 5472.2 5472.3 5472.4 3995.2 4105.9 4106.7 4113.4 4122.7 4115.9 4120.9 4132.9 4137.4 4142.4 4080.0 4082.0 4084.3 4086.5 4087.0 4085.2 4090.3 4091.4 4101.4 4101.6 3597.6 3602.6 3605.5 3609.0 3612.6 5378.3 5411.1 5420.8 5421.7 5452.2 4829.3 4834.8 4836.6 4840.1 4841.9 5840.5 5845.9 5854.2 5856.9 5872.9 4033.7 4043.5 4047.5 4055.1 4055.1 5800.6 6132.8 6150.9 6195.2 6197.7 4015.0 4041.4 4054.9 4057.6 4061.5 4091.2 4101.7 4109.7 4111.2 4112.9 4633.5 4757.4 4758.5 4761.8 4787.4 5820.7 5842.0 5857.2 5870.3 5873.9 1426.7 1429.0 1430.0 1432.8 1436.5 934.2 952.4 976.4 980.4 982.4 5013.3 5023.5 5044.0 5047.6 5047.8 5976.2 5985.2 6008.3 6010.5 6018.6 4972.5 4980.5 4990.7 4992.8 4993.1 3155.5 3177.7 3187.7 3200.9 3204.0 5536.1 5591.7 5594.0 5601.8 5603.5 6156.0 6175.7 6199.2 6205.7 6205.9 5520.9 5550.5 5551.0 5552.8 5553.3 5983.1 5987.4 5994.1 5996.5 6007.5 5907.3 5922.1 5929.4 5938.7 5950.4 5335.2 5399.4 5465.9 5533.4 5541.1 4025.3 4030.0 4031.5 4050.4 4051.8 6031.6 6044.0 6044.7 6050.5 6058.7 5663.7 5848.3 5869.3 5886.8 5888.2 5828.9 5830.8 5843.4 5868.5 5872.5 5755.6 5757.9 5761.2 5776.5 5790.0 5898.0 5901.6 5905.4 5909.3 5936.5 5694.6 5712.0 5721.6 5730.1 5773.4 18:59:48 INFO - PID 19880 | 18:59:48 INFO - PID 19880 | [#5] yui.html Cycles:180 Average:16658.97 Median:4037.72 stddev:21936.79 (543.3%) stddev-sans-first:21965.09 18:59:48 INFO - PID 19880 | Values: 578.3 582.5 648.9 667.7 670.7 11650.5 11952.8 12086.8 15049.8 16061.4 14449.7 14568.7 14630.0 14638.2 14684.5 798.8 809.7 810.7 813.5 818.8 783.6 804.5 809.9 815.8 816.2 860.0 860.1 861.6 862.0 862.4 849.9 856.7 858.2 859.4 861.9 607.4 622.9 626.9 627.6 630.2 13696.7 13853.4 13859.7 13884.5 13903.5 12458.6 13399.0 13412.0 13438.8 13442.2 11010.8 11156.7 11229.6 11249.3 11295.4 2966.9 2968.0 2982.7 2990.6 3005.7 76938.3 79035.6 79213.0 79851.0 80213.0 10976.3 11469.4 11500.9 11501.0 11594.8 14962.8 15459.9 19445.9 20080.8 20456.6 5952.5 6104.6 6120.4 6121.2 6139.8 2890.2 2912.3 2948.4 2949.0 2959.7 3719.2 3787.5 3823.6 3851.3 3851.7 664.3 674.1 675.6 676.0 679.3 497.8 506.4 506.7 509.8 514.0 10251.7 10401.1 10464.5 10853.8 11133.6 435.2 447.6 449.0 505.9 513.6 4223.7 4307.9 4345.0 4373.3 4375.8 73762.0 76588.0 77762.6 80870.6 80894.2 64981.0 65320.0 65514.7 67619.7 67858.7 59418.4 61143.4 61384.0 62051.0 62222.4 8320.8 8427.0 8442.2 8459.5 8522.1 26489.6 26976.6 27017.0 27030.0 28058.0 33440.5 59570.0 60321.4 60386.7 60951.4 13596.7 13762.4 13887.0 13900.7 14447.1 14936.5 15148.8 15477.0 15665.1 15827.7 13265.9 13326.2 13353.9 13443.2 13639.2 14063.8 14117.6 14226.5 14320.4 14432.7 14618.5 14915.6 15124.3 15282.0 15432.5 8582.8 8720.6 9150.2 9282.3 9309.9 10602.3 10855.9 10979.7 11011.6 11374.9 18:59:48 INFO - PID 19880 | -------- Summary: end -------- 18:59:48 INFO - PID 19880 | 18:59:49 INFO - TEST-INFO | 19880: exit 0 18:59:49 INFO - TEST-OK | dromaeo_css | took 1147715ms 18:59:49 INFO - TEST-START | kraken 18:59:49 INFO - operating with platform_type : linux_ 18:59:49 INFO - Initialising browser for kraken test... 18:59:49 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43651/getInfo.html -profile /tmp/tmpTO4l_Z/profile 18:59:49 INFO - TEST-INFO | started process 20300 (/builds/slave/test/build/application/firefox/firefox http://localhost:43651/getInfo.html) 19:00:24 INFO - TEST-INFO | 20300: killed by SIGTERM 19:00:24 INFO - Browser initialized. 19:00:24 INFO - Running cycle 1/1 for kraken test... 19:00:24 INFO - TEST-INFO | started process 20529 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTO4l_Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:00:36 INFO - PID 20529 | RSS: Main: 188280832 19:00:36 INFO - PID 20529 | 19:00:39 INFO - PID 20529 | Cycle 1(1): loaded http://localhost:43651/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43651/tests/kraken/driver.html?testName=audio-beat-detection) 19:00:40 INFO - PID 20529 | RSS: Main: 191913984 19:00:40 INFO - PID 20529 | 19:00:43 INFO - PID 20529 | Cycle 1(1): loaded http://localhost:43651/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43651/tests/kraken/driver.html?testName=audio-dft) 19:00:43 INFO - PID 20529 | RSS: Main: 190640128 19:00:43 INFO - PID 20529 | 19:00:46 INFO - PID 20529 | Cycle 1(1): loaded http://localhost:43651/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43651/tests/kraken/driver.html?testName=audio-fft) 19:00:47 INFO - PID 20529 | RSS: Main: 186163200 19:00:47 INFO - PID 20529 | 19:00:49 INFO - PID 20529 | Cycle 1(1): loaded http://localhost:43651/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43651/tests/kraken/driver.html?testName=audio-oscillator) 19:00:50 INFO - PID 20529 | RSS: Main: 186380288 19:00:50 INFO - PID 20529 | 19:00:52 INFO - PID 20529 | Cycle 1(1): loaded http://localhost:43651/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43651/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:00:53 INFO - PID 20529 | RSS: Main: 186347520 19:00:53 INFO - PID 20529 | 19:00:56 INFO - PID 20529 | Cycle 1(1): loaded http://localhost:43651/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43651/tests/kraken/driver.html?testName=imaging-darkroom) 19:00:56 INFO - PID 20529 | RSS: Main: 187392000 19:00:56 INFO - PID 20529 | 19:01:00 INFO - PID 20529 | Cycle 1(1): loaded http://localhost:43651/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43651/tests/kraken/driver.html?testName=imaging-desaturate) 19:01:01 INFO - PID 20529 | RSS: Main: 186220544 19:01:01 INFO - PID 20529 | 19:01:03 INFO - PID 20529 | Cycle 1(1): loaded http://localhost:43651/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43651/tests/kraken/driver.html?testName=json-parse-financial) 19:01:04 INFO - PID 20529 | RSS: Main: 187310080 19:01:04 INFO - PID 20529 | 19:01:06 INFO - PID 20529 | Cycle 1(1): loaded http://localhost:43651/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43651/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:01:06 INFO - PID 20529 | RSS: Main: 187318272 19:01:06 INFO - PID 20529 | 19:01:08 INFO - PID 20529 | Cycle 1(1): loaded http://localhost:43651/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43651/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:01:09 INFO - PID 20529 | RSS: Main: 186761216 19:01:09 INFO - PID 20529 | 19:01:11 INFO - PID 20529 | Cycle 1(1): loaded http://localhost:43651/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43651/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:01:12 INFO - PID 20529 | RSS: Main: 187027456 19:01:12 INFO - PID 20529 | 19:01:15 INFO - PID 20529 | Cycle 1(1): loaded http://localhost:43651/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43651/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:01:15 INFO - PID 20529 | RSS: Main: 187203584 19:01:15 INFO - PID 20529 | 19:01:18 INFO - PID 20529 | Cycle 1(1): loaded http://localhost:43651/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43651/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:01:19 INFO - PID 20529 | RSS: Main: 187117568 19:01:19 INFO - PID 20529 | 19:01:21 INFO - PID 20529 | Cycle 1(1): loaded http://localhost:43651/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43651/tests/kraken/driver.html?testName=ai-astar) 19:01:21 INFO - PID 20529 | RSS: Main: 189042688 19:01:21 INFO - PID 20529 | 19:01:21 INFO - PID 20529 | __start_tp_report 19:01:21 INFO - PID 20529 | _x_x_mozilla_page_load 19:01:21 INFO - PID 20529 | _x_x_mozilla_page_load_details 19:01:21 INFO - PID 20529 | |i|pagename|runs| 19:01:21 INFO - PID 20529 | |0;ai-astar;103;112;109;109;109;110;110;110;109;111 19:01:21 INFO - PID 20529 | |1;audio-beat-detection;149;130;126;166;124;123;124;123;144;126 19:01:21 INFO - PID 20529 | |2;audio-dft;163;163;163;167;166;168;174;164;162;167 19:01:21 INFO - PID 20529 | |3;audio-fft;74;77;74;105;75;78;76;75;92;76 19:01:21 INFO - PID 20529 | |4;audio-oscillator;83;83;106;84;84;84;97;84;83;109 19:01:21 INFO - PID 20529 | |5;imaging-gaussian-blur;114;115;114;113;115;114;114;115;113;115 19:01:21 INFO - PID 20529 | |6;imaging-darkroom;151;151;155;152;153;153;151;150;149;149 19:01:21 INFO - PID 20529 | |7;imaging-desaturate;96;95;94;95;94;95;95;95;95;94 19:01:21 INFO - PID 20529 | |8;json-parse-financial;55;56;60;56;55;57;55;58;56;56 19:01:21 INFO - PID 20529 | |9;json-stringify-tinderbox;57;56;56;56;56;54;56;56;58;56 19:01:21 INFO - PID 20529 | |10;stanford-crypto-aes;88;86;86;88;89;87;89;87;116;87 19:01:21 INFO - PID 20529 | |11;stanford-crypto-ccm;139;138;135;135;133;136;141;130;139;143 19:01:21 INFO - PID 20529 | |12;stanford-crypto-pbkdf2;192;197;196;195;193;200;210;195;195;191 19:01:21 INFO - PID 20529 | |13;stanford-crypto-sha256-iterative;77;73;72;73;75;71;71;76;72;72 19:01:21 INFO - PID 20529 | __end_tp_report 19:01:21 INFO - PID 20529 | __start_cc_report 19:01:21 INFO - PID 20529 | _x_x_mozilla_cycle_collect,1037 19:01:21 INFO - PID 20529 | __end_cc_report 19:01:21 INFO - PID 20529 | __startTimestamp1496368881665__endTimestamp 19:01:21 INFO - PID 20529 | 19:01:21 INFO - PID 20529 | ------- Summary: start ------- 19:01:21 INFO - PID 20529 | Number of tests: 14 19:01:21 INFO - PID 20529 | 19:01:21 INFO - PID 20529 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:2.39 (2.2%) stddev-sans-first:1.05 19:01:21 INFO - PID 20529 | Values: 103.0 112.0 109.0 109.0 109.0 110.0 110.0 110.0 109.0 111.0 19:01:21 INFO - PID 20529 | 19:01:21 INFO - PID 20529 | [#1] audio-beat-detection Cycles:10 Average:133.50 Median:128.00 stddev:14.65 (11.4%) stddev-sans-first:14.43 19:01:21 INFO - PID 20529 | Values: 149.0 130.0 126.0 166.0 124.0 123.0 124.0 123.0 144.0 126.0 19:01:21 INFO - PID 20529 | 19:01:21 INFO - PID 20529 | [#2] audio-dft Cycles:10 Average:165.70 Median:166.50 stddev:3.59 (2.2%) stddev-sans-first:3.67 19:01:21 INFO - PID 20529 | Values: 163.0 163.0 163.0 167.0 166.0 168.0 174.0 164.0 162.0 167.0 19:01:21 INFO - PID 20529 | 19:01:21 INFO - PID 20529 | [#3] audio-fft Cycles:10 Average:80.20 Median:76.00 stddev:10.20 (13.4%) stddev-sans-first:10.56 19:01:21 INFO - PID 20529 | Values: 74.0 77.0 74.0 105.0 75.0 78.0 76.0 75.0 92.0 76.0 19:01:21 INFO - PID 20529 | 19:01:21 INFO - PID 20529 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:84.00 stddev:10.31 (12.3%) stddev-sans-first:10.64 19:01:21 INFO - PID 20529 | Values: 83.0 83.0 106.0 84.0 84.0 84.0 97.0 84.0 83.0 109.0 19:01:21 INFO - PID 20529 | 19:01:21 INFO - PID 20529 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.50 stddev:0.79 (0.7%) stddev-sans-first:0.83 19:01:21 INFO - PID 20529 | Values: 114.0 115.0 114.0 113.0 115.0 114.0 114.0 115.0 113.0 115.0 19:01:21 INFO - PID 20529 | 19:01:21 INFO - PID 20529 | [#6] imaging-darkroom Cycles:10 Average:151.40 Median:151.50 stddev:1.90 (1.3%) stddev-sans-first:2.01 19:01:21 INFO - PID 20529 | Values: 151.0 151.0 155.0 152.0 153.0 153.0 151.0 150.0 149.0 149.0 19:01:21 INFO - PID 20529 | 19:01:21 INFO - PID 20529 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 19:01:21 INFO - PID 20529 | Values: 96.0 95.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 19:01:21 INFO - PID 20529 | 19:01:21 INFO - PID 20529 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.00 stddev:1.58 (2.8%) stddev-sans-first:1.59 19:01:21 INFO - PID 20529 | Values: 55.0 56.0 60.0 56.0 55.0 57.0 55.0 58.0 56.0 56.0 19:01:21 INFO - PID 20529 | 19:01:21 INFO - PID 20529 | [#9] json-stringify-tinderbox Cycles:10 Average:56.10 Median:56.00 stddev:0.99 (1.8%) stddev-sans-first:1.00 19:01:21 INFO - PID 20529 | Values: 57.0 56.0 56.0 56.0 56.0 54.0 56.0 56.0 58.0 56.0 19:01:21 INFO - PID 20529 | 19:01:21 INFO - PID 20529 | [#10] stanford-crypto-aes Cycles:10 Average:90.30 Median:87.50 stddev:9.09 (10.4%) stddev-sans-first:9.61 19:01:21 INFO - PID 20529 | Values: 88.0 86.0 86.0 88.0 89.0 87.0 89.0 87.0 116.0 87.0 19:01:21 INFO - PID 20529 | 19:01:21 INFO - PID 20529 | [#11] stanford-crypto-ccm Cycles:10 Average:136.90 Median:138.50 stddev:3.87 (2.8%) stddev-sans-first:4.03 19:01:21 INFO - PID 20529 | Values: 139.0 138.0 135.0 135.0 133.0 136.0 141.0 130.0 139.0 143.0 19:01:21 INFO - PID 20529 | 19:01:21 INFO - PID 20529 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.40 Median:195.50 stddev:5.42 (2.8%) stddev-sans-first:5.51 19:01:21 INFO - PID 20529 | Values: 192.0 197.0 196.0 195.0 193.0 200.0 210.0 195.0 195.0 191.0 19:01:21 INFO - PID 20529 | 19:01:21 INFO - PID 20529 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.20 Median:73.00 stddev:2.10 (2.9%) stddev-sans-first:1.72 19:01:21 INFO - PID 20529 | Values: 77.0 73.0 72.0 73.0 75.0 71.0 71.0 76.0 72.0 72.0 19:01:21 INFO - PID 20529 | -------- Summary: end -------- 19:01:21 INFO - PID 20529 | 19:01:22 INFO - TEST-INFO | 20529: exit 0 19:01:22 INFO - TEST-OK | kraken | took 93029ms 19:01:22 INFO - SUITE-END | took 1240s 19:01:23 INFO - Completed test suite (00:20:41) 19:01:23 INFO - javascript benchmark 19:01:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6580.867979945263, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2672.016688875248, 2710.4850078485097, 2731.085086496024, 2747.2307753828927, 2749.615053892454, 5095.643304968654, 5202.0376230397305, 5244.816431424901, 5256.106461901476, 5279.234510995908, 5143.81996630118, 5186.507281808232, 5218.0, 5287.86780330491, 5310.8406747797535, 4664.3936288282475, 4688.273317635755, 4689.413823272091, 4704.1062198182235, 4745.240761478164, 4689.812407503713, 4695.037517308961, 4752.120857641347, 4777.546133117366, 4819.903601927959, 4540.341650460665, 4577.176108300505, 4678.578927896471, 4687.484376718558, 4737.549932756383, 4639.628829693616, 4658.604018658418, 4706.599939005188, 4708.529147085298, 4729.668923175379, 4645.187092258841, 4645.721256724607, 4657.930131048037, 4662.114198302312, 4701.835435759732, 5191.351081114861, 5242.580593552507, 5249.212618107276, 5258.1849813279005, 5270.525652691276, 5521.503064724194, 5605.831825045255, 5606.691631960241, 5683.0, 5696.886062278772, 5746.224259724967, 5746.913796293059, 5750.453706897838, 5780.624259423124, 5804.477597016289, 5343.812966546191, 5347.705876176848, 5348.277982472394, 5350.277712508761, 5351.1973204019705, 5695.430456954271, 5753.913691294634, 5773.191753154561, 5886.705664716747, 5886.970565147147, 5525.613207075547, 5576.191452239484, 5589.413111623302, 5613.46672066153, 5628.04323265046, 5621.747021384048, 5645.887082258332, 5656.236408084856, 5669.121286200645, 5677.233573467612, 5493.23094766733, 5522.696251706195, 5623.915641265385, 5626.381098079208, 5647.0, 5483.862903427446, 5542.612017158841, 5550.833474995757, 5557.916631250535, 5571.777128914879, 4850.805967761321, 4875.463698993108, 4876.683015603974, 4878.707277563358, 4922.778474968635, 4130.710850240454, 4145.233131870553, 4151.14901445203, 4162.334026555736, 4203.789810509462, 4687.273472611751, 4743.312219728189, 4750.097481478508, 4780.402449693788, 4799.256115302133, 5664.575156863251, 5665.886682266331, 5675.347335056521, 5676.574256930747, 5710.743016564182, 4763.499832517605, 4765.69023013503, 4777.283407488835, 4783.928241076386, 4814.759262036954, 4922.803087876517, 4992.301077849104, 5011.1481048221885, 5024.321716568216, 5037.068142393596, 5237.659552129099, 5285.63000589955, 5286.788528458972, 5289.41816400188, 5297.470252974672, 5485.807996720096, 5566.860828479321, 5637.069883469182, 5657.660540367591, 5684.63049901755, 5207.505286997729, 5223.608229382888, 5305.575553955751, 5328.387235467816, 5339.626226164287, 5454.618176727591, 5545.584081193846, 5554.777808887599, 5567.638103523258, 5583.916241256303, 5562.443755624567, 5638.633488823213, 5660.037793575019, 5734.3692193857805, 5766.826995190151, 5472.370677372153, 5519.144532597294, 5527.695976721319, 5528.502434780889, 5574.86062848432, 5519.2824932758485, 5520.1167813151305, 5523.530499907392, 5528.44715528444, 5536.861578460571, 5259.237410575522, 5330.493603107699, 5409.594280429063, 5432.158015507603, 5437.945620543744, 5586.469285417878, 5605.803796867253, 5608.6073974823, 5642.717864106696, 5643.802466913638, 5413.458654134555, 5424.511793938565, 5437.592180586393, 5437.619366644297, 5444.373897001737], "value": 5134.034822319391, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.1454254894128, 741.162486390379, 760.9429292803039, 954.2890546542826, 963.5037955452939, 30222.395552088947, 30698.0, 30815.22961925953, 30860.845695771546, 31096.689033109662, 31857.362852742932, 32155.678443215562, 32163.67836321636, 32224.355512889728, 32305.67694323056, 6437.549371543993, 6620.073189753439, 6850.486213533993, 6971.721131154748, 6987.82530436738, 6600.570962887397, 6684.632345221011, 6701.832454188636, 6711.5301928865, 6713.0, 6660.100886380349, 6700.731970721165, 6713.26154123046, 6713.56361836479, 6717.630530320855, 6587.308332625077, 6645.501587380917, 6689.163854518185, 6689.397954184123, 6695.062691223233, 6585.80242592723, 6615.867682646368, 6631.171103612049, 6631.767888123893, 6632.602043877383, 30773.0, 31002.37995240105, 31044.53433198504, 31351.529727054112, 31636.525452118236, 2687.314734742628, 2714.4978179036943, 2715.4297597504547, 2717.1033558925506, 2723.060544112278, 23660.64509032366, 23667.0, 23712.64431033536, 23714.881425592936, 24089.156879509133, 2690.394661201214, 2727.290904364879, 2729.4541091781525, 2731.549294366447, 2732.303262668027, 122075.0, 122969.0, 130745.0, 139972.0, 141025.0, 37729.245415091544, 37931.81034094812, 38451.42322865159, 38524.8073759635, 38599.228015440094, 39377.40933885994, 40193.0, 40312.39531407031, 40350.0, 40437.39343909785, 11146.721331966604, 11285.322880627189, 11290.943545282222, 11294.54821807135, 11317.773644527064, 8868.33487488441, 8880.777980550409, 8886.066962968924, 8894.555272236492, 8900.287976961827, 12047.759044819055, 12187.268763874195, 12256.406667133215, 12265.632031039084, 12396.938015310046, 5124.487551244845, 5322.2548843161985, 5350.224217488442, 5360.169173777993, 5417.4311697272005, 770.8843673448915, 804.9114597394282, 808.3654331349862, 808.890799742039, 822.9711960081369, 18146.546336341435, 18490.167942442622, 18516.537086572942, 18680.53298667544, 19508.12213450398, 846.1200351634232, 857.1771099744191, 871.9433236839585, 874.6894852327459, 882.8057827277988, 9755.170810481046, 9882.407055576688, 10174.694759157237, 10176.898231017594, 10282.897171028344, 169303.15348423427, 169607.1519642394, 169665.0, 170026.0, 170196.32153337944, 32604.0, 32610.510842337382, 32683.346333073205, 32769.0, 32895.506567401506, 1101.2291396022815, 1130.745582244005, 1179.6991767099507, 1193.2124797633694, 1211.3943028485758, 18778.12218778111, 19692.40922772319, 20251.79748202499, 20392.694109588072, 20429.182832686525, 28371.148865534065, 28430.289242769097, 28585.0, 28623.0, 28760.424791504473, 146119.0, 147181.0, 147617.0, 148165.25917370344, 148356.0, 20767.896160519704, 20912.1635134599, 24412.0, 24824.0, 25068.62397064082, 29307.70692293135, 29672.0, 29899.850500747358, 29929.850350748107, 30202.54696179515, 23204.419889502897, 23291.3012609622, 23390.883045585342, 23875.880620596785, 23946.76053239515, 22404.439889002904, 23165.536689266457, 23313.76686233116, 23421.531569368857, 23900.28299151028, 25487.36281592975, 29410.11769646914, 29823.850880745456, 31038.0, 31223.375532489677, 26480.867595661897, 26539.469210616066, 26543.7345626549, 26974.32564185911, 27312.0, 19391.3213037543, 21326.0, 21392.544901050132, 21418.250361237282, 21665.35003949884], "value": 13371.482863438823, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.6957282038471, 406.54670042902154, 413.6947929283113, 427.7540414261799, 427.916556271527, 17462.0, 17994.460166195004, 18031.81968180318, 18077.548061298443, 18792.812071879278, 19216.135273912674, 19752.111154998023, 19833.305834295803, 19852.50368740782, 19890.900545497254, 5609.298837645294, 5723.4848863602265, 5733.971330143343, 5735.741891614887, 5769.538436925036, 5711.514521265697, 5731.340895796974, 5755.82732518023, 5758.654480731148, 5777.884442311151, 5124.436312005695, 5657.575681823859, 5720.9713951430185, 5728.255326807509, 5757.913631295534, 5150.227465880129, 5192.7144007079405, 5204.583633309327, 5225.712585807779, 5248.239005344223, 4711.505291944365, 4750.239961606127, 4767.165745994437, 4773.260144677581, 4790.329353890458, 22827.77172228273, 23350.299491015296, 23359.532809343887, 23381.41546461335, 23465.648015279785, 1647.5139833748954, 1676.773635559196, 1681.697294486992, 1682.730763077914, 1685.5112017514905, 15538.61153471161, 15775.92112039444, 15820.76268855968, 15885.126318052502, 15889.761653575206, 2099.4331530486834, 2112.5141217519904, 2135.124598914453, 2152.182170775111, 2168.642174041281, 104379.0, 105125.0, 105265.0, 110212.0, 111170.0, 11052.0, 11356.54573817038, 11381.601643942422, 11628.88371116278, 11748.236364636272, 15899.125548094966, 16028.358865645478, 16068.598285042968, 16075.758863617055, 16105.436309729103, 7144.8928266076055, 7277.490575659759, 7316.414686825041, 7562.243775622504, 7572.962135189399, 6693.196816382066, 6778.457723382117, 6819.488538359643, 6850.588964662136, 6852.9783713804545, 7331.193568707438, 7347.853042939111, 7368.410527157815, 7489.251074892467, 7522.285382888617, 1953.2870502266571, 1971.132002935725, 1974.9111289991986, 2008.6886532587473, 2225.3880182949492, 800.3157300507982, 830.9293710034594, 832.8459235041537, 840.5167028958373, 844.0926004545139, 17107.65784684324, 17388.565285867953, 17629.55926101832, 18097.36659216921, 18372.173252203684, 822.9218224268685, 823.6828820903995, 824.1099612418574, 832.675256649907, 844.3709436469869, 9331.16019558243, 9426.481543515172, 9696.854547181798, 9767.51162441875, 9972.750681233027, 359282.0, 364380.0, 403688.0, 406325.0, 417066.0, 90566.54716726506, 93547.0, 93555.53222233846, 94339.0, 95400.0, 833.295864994079, 868.2402897464718, 1005.5676059294574, 1008.1128606825946, 1051.584624073502, 17168.570785730455, 17436.564085897448, 18192.909035454737, 18615.627687446446, 18794.15426305847, 46287.12252620564, 47359.0, 47537.5246247547, 47826.0, 47972.7601361991, 58857.70571147288, 59045.409545905706, 59050.40949590621, 59145.70427148009, 59315.406845930986, 13473.0, 13647.317634118055, 13649.931750341184, 13771.0, 13829.170249785046, 15430.0, 15449.382024718885, 15474.226288685746, 15487.922560387577, 15687.137207453243, 12488.25070495773, 13086.476540938636, 13090.541831035867, 13103.344832758134, 13173.341332933507, 11811.468483918416, 11878.287302761863, 11894.583689570823, 12046.0, 12593.118481706193, 13172.209667419602, 13746.450141994608, 13765.38055787472, 13781.104228225133, 13798.0, 13656.453741850612, 13831.308434578432, 13875.514356997457, 13961.232132232824, 13986.790198147239, 12928.353582321035, 12953.158044727063, 13084.149530280501, 13131.803022954855, 13208.27354495512], "value": 9592.4189158354, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1204.8855358740918, 1248.9625311240661, 1257.0320852943228, 1268.632096691959, 1272.1985149355905, 9227.492487913161, 9431.0, 9449.574769135388, 9862.063104005127, 9871.605135794569, 8694.304455643549, 8745.125487451252, 8803.295736341093, 8830.91169088309, 8859.335549833757, 2027.6147531968916, 2063.401613532074, 2065.8760474371584, 2072.347210628647, 2074.3776866939934, 1846.0677357934223, 1888.8205620466033, 1892.1201641236821, 1892.6593213221615, 1899.1074195128267, 2010.6280338137492, 2043.3052762060897, 2054.1783286685295, 2054.4966483211633, 2056.0542150610736, 1970.2217624038497, 1977.0707767349322, 1979.0302751651732, 1982.0684278389206, 1983.4148926066846, 1940.4469726128127, 1941.262320318284, 1982.9206831726713, 2055.98972005139, 2063.7110804487384, 9692.22462203022, 9772.169365603932, 9794.16749576287, 9835.557399917021, 9868.95065524675, 5046.772895219724, 5240.109181439165, 5253.106971814801, 5257.0274499217385, 5265.6840589564745, 3046.329807442359, 3175.126840118986, 3210.2295449092285, 3221.3396253768155, 3225.758068144875, 967.685502211784, 976.9804603907882, 1000.3697670467559, 1002.6440613582146, 1004.1063453526367, 12841.486340546368, 13213.141145825586, 14556.272186390745, 14691.55925322242, 14724.0, 4307.849225277163, 4408.58118478744, 4416.337549367557, 4434.379186913835, 4467.865964021084, 10425.843612345821, 10480.056794888496, 10522.473876306154, 10524.36853788775, 10545.47272636365, 5074.797008119708, 5076.974615126901, 5082.466341034212, 5091.490850914879, 5098.847034588968, 4678.157931572282, 4691.483936766953, 4700.506446823103, 4820.9517904821205, 4826.1795494765975, 3680.4847321375028, 3797.2974999625158, 3827.61723827615, 3851.9229615407535, 3858.749181303206, 1119.361963680694, 1130.6887779138785, 1134.495149658394, 1135.982960255597, 1136.5056200552785, 607.5564837668527, 628.9402357028331, 632.3170975346615, 633.2053273142177, 634.4702173685025, 4851.975740121276, 4896.853094407174, 4903.95096049035, 4909.091818013679, 4967.379077615298, 511.2357026245712, 528.0336983320515, 529.499622856397, 530.2152813835545, 530.8327876718821, 3094.1491089950446, 3293.884714034997, 3305.272839975202, 3314.320564284316, 3371.3762953853616, 11887.0, 12661.36693165338, 12674.36628168588, 12740.108192426627, 12770.106092573616, 11341.603043893589, 11484.0, 11491.77016459666, 11519.769604607862, 11544.249623774596, 5881.294244690579, 5947.434993675594, 5992.13114098462, 6009.128676341993, 6061.393860613992, 4908.7545622719435, 5155.587552995827, 5168.870778230424, 5297.470252974672, 5349.732513374238, 11332.206745527734, 11429.0, 11507.94246028798, 11556.59551915679, 11627.941860290644, 10788.460576970963, 11725.589604363806, 11829.231099978473, 11877.406129693654, 12043.458044388199, 6843.657817109224, 7016.193137789015, 7026.859462810818, 7098.219195888345, 7134.393576546052, 8592.914070859211, 8751.562421879007, 8754.0, 8782.385233033627, 8782.780430489289, 7158.141023077264, 7506.924930750841, 7678.5392876427595, 7739.071311442663, 7821.100573434128, 7004.544704594185, 7068.151821781419, 7114.608696521534, 7145.249748776304, 7210.134783825974, 6311.116443697794, 6316.684165791784, 6396.456301214263, 6412.871742565216, 6422.454091402283, 4564.475085365093, 4583.6562257831465, 4665.183592871302, 4689.929651055305, 4841.298011788201, 4884.169691152583, 4908.288298196813, 4943.77753001123, 4981.227909673861, 5101.7194054327365], "value": 4282.682536900715, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.5348779148149, 344.7052769881753, 346.2520954737766, 348.1974049815175, 351.8557391469498, 5627.409122042188, 5643.435656434354, 5655.886882262353, 5665.405132461089, 5677.48902598766, 5459.816073570574, 5469.179623056533, 5472.2338872557875, 5472.34331880174, 5472.398036216013, 3995.22093191827, 4105.9178816423655, 4106.691998100139, 4113.403556484308, 4122.670186385097, 4115.8971025724295, 4120.855770048049, 4132.876013719593, 4137.420761093449, 4142.399352093945, 4079.9796001019954, 4081.979590102045, 4084.264832330179, 4086.4687590613325, 4086.9591304087025, 4085.22380747657, 4090.325096359097, 4091.4476545666403, 4101.405296232029, 4101.630853223194, 3597.6328994982, 3602.6397360264027, 3605.4856960076568, 3608.981955090234, 3612.6026137124895, 5378.327709036371, 5411.134218525057, 5420.810271640513, 5421.674699518042, 5452.182172674091, 4829.251466022737, 4834.830780922686, 4836.637252206064, 4840.128776820171, 4841.878953026203, 5840.474357307863, 5845.912311315334, 5854.18041474194, 5856.941430585724, 5872.941270587282, 4033.6773058155277, 4043.5349934757587, 4047.4535937648334, 4055.1078762672164, 4055.1281474482835, 5800.622959507618, 6132.754689812402, 6150.907736384002, 6195.163652906845, 6197.690115494207, 4014.979925100356, 4041.3533834586915, 4054.9391759123637, 4057.5739547347694, 4061.5329237138108, 4091.161311931047, 4101.733387329814, 4109.691773117028, 4111.157212771374, 4112.856050038235, 4633.536646335407, 4757.405324334458, 4758.5241475852135, 4761.761911904391, 4787.40157480315, 5820.679862607512, 5841.970790146022, 5857.15071314657, 5870.26621672291, 5873.949831673298, 1426.657602175491, 1428.9714205715827, 1429.9765831348734, 1432.777919422491, 1436.5115860607443, 934.2245935873344, 952.4333021851987, 976.4043933200742, 980.4117529482396, 982.415462799633, 5013.323201367842, 5023.472535383805, 5043.9747801260755, 5047.621428392885, 5047.798088076436, 5976.163337132805, 5985.221921150222, 6008.279006519246, 6010.459058684739, 6018.638881667114, 4972.453030166679, 4980.452150263468, 4990.6506544541535, 4992.750362481861, 4993.1262029144755, 3155.5266709993684, 3177.650458449615, 3187.7131058204873, 3200.919977000547, 3203.9839800800846, 5536.141898005815, 5591.7483713233005, 5594.0, 5601.831945041656, 5603.523700485504, 6155.96922015396, 6175.714985455321, 6199.194104766351, 6205.689715514206, 6205.906911396332, 5520.91718624221, 5550.47270509301, 5551.0, 5552.7778888843995, 5553.333599968029, 5983.132445795422, 5987.371326010706, 5994.100884867305, 5996.520278377632, 6007.4893634039845, 5907.32065812437, 5922.141289512911, 5929.436703513159, 5938.673372964356, 5950.434708702666, 5335.1730481775385, 5399.4060653327315, 5465.890682186414, 5533.363663178786, 5541.141123125922, 4025.315696331689, 4029.9597004029583, 4031.496062992126, 4050.3924411338535, 4051.8379264829077, 6031.577789554689, 6043.969780151247, 6044.7279872406725, 6050.45545900871, 6058.7273572688455, 5663.677892064234, 5848.298204215351, 5869.266341707286, 5886.793962211302, 5888.205092312483, 5828.854278643068, 5830.82507524775, 5843.386444423274, 5868.501177399969, 5872.500837428866, 5755.5683323750045, 5757.884842303214, 5761.193432919311, 5776.537876969916, 5790.0, 5897.997340452219, 5901.557383196363, 5905.40945905406, 5909.349971503218, 5936.465718085393, 5694.576355911022, 5711.971440142773, 5721.628094173865, 5730.111832665943, 5773.364929857797], "value": 4321.665995971801, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.2800413485212, 582.5000623394759, 648.9383508566686, 667.7128834601119, 670.664667666167, 11650.533978640855, 11952.7609447811, 12086.758264834709, 15049.849501504981, 16061.437849675234, 14449.711005779878, 14568.708625827478, 14629.975901686887, 14638.194899280536, 14684.486042988498, 798.8402319536101, 809.7368355284526, 810.6514198894473, 813.4509206285763, 818.8075802186481, 783.6356094416095, 804.5454318310166, 809.9230573095576, 815.8449894520052, 816.1675091406792, 859.9570021498931, 860.1312674199073, 861.5649097205902, 862.0259107208846, 862.3833958719514, 849.8725191221366, 856.6530555125184, 858.1804376820153, 859.4027151129967, 861.8922634670666, 607.3774381259201, 622.8785386849567, 626.9059641053833, 627.6077451592755, 630.180765005491, 13696.65758356049, 13853.376598053112, 13859.653508662263, 13884.51404200848, 13903.513377031755, 12458.563950261789, 13399.0, 13412.0, 13438.798418023738, 13442.193468391928, 11010.834837477445, 11156.721081972935, 11229.60696375631, 11249.325040497515, 11295.378754168518, 2966.9406611867644, 2968.0, 2982.746466550324, 2990.5514172874027, 3005.6844031376827, 76938.3051796453, 79035.60482197552, 79213.0, 79851.0, 80213.0, 10976.341419514854, 11469.426528673534, 11500.94249528747, 11501.0, 11594.76810463786, 14962.775558366633, 15459.92270038665, 19445.90277048634, 20080.799192007893, 20456.590868182553, 5952.464278214895, 6104.603200791934, 6120.387961203844, 6121.204243448323, 6139.84650383744, 2890.1762997545597, 2912.271932016996, 2948.4250571138423, 2948.9852550737537, 2959.6596391414832, 3719.1631882826687, 3787.5454945406177, 3823.636754508317, 3851.268259030775, 3851.7111216658864, 664.3124366280877, 674.0798809624827, 675.598019178588, 676.0197713315712, 679.2765704524666, 497.76107468415364, 506.4150905703918, 506.7035784066289, 509.81391791995657, 513.9614528910347, 10251.743706407251, 10401.115905148146, 10464.52909619069, 10853.782924341469, 11133.610323638633, 435.2426777407289, 447.60834270013737, 449.0188937172289, 505.8794769585386, 513.5609054258555, 4223.72545784523, 4307.892302692395, 4345.000649850489, 4373.300271956472, 4375.78121093944, 73762.0, 76588.0, 77762.61118694484, 80870.59564702139, 80894.19105808984, 64981.0, 65320.0, 65514.67242663756, 67619.66190169018, 67858.66070669713, 59418.405815942155, 61143.38856611377, 61384.0, 62051.0, 62222.377776221656, 8320.791980200544, 8426.95786521088, 8442.197991190827, 8459.534725590152, 8522.105178956368, 26489.602655959792, 26976.595351069358, 27017.0, 27030.0, 28058.0, 33440.49839252462, 59570.0, 60321.396786031575, 60386.69806650939, 60951.39048609457, 13596.728065438438, 13762.449502019806, 13887.0, 13900.721985560434, 14447.060941038799, 14936.477223297132, 15148.848511514743, 15476.993995390263, 15665.138417387154, 15827.683446331239, 13265.867341326462, 13326.200427973965, 13353.933230334174, 13443.193408395528, 13639.181649101085, 14063.789043164565, 14117.647058823612, 14226.50207242783, 14320.427182912566, 14432.711345773236, 14618.488352907598, 14915.627109322353, 15124.319405626553, 15282.0, 15432.537023889301, 8582.828343432971, 8720.563971801512, 9150.176484116462, 9282.257419406296, 9309.86035209486, 10602.25784195099, 10855.891441085803, 10979.670609881716, 11011.61459348919, 11374.886251137383], "value": 6663.9545401770565, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1548.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 111.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 130.0, 126.0, 166.0, 124.0, 123.0, 124.0, 123.0, 144.0, 126.0], "value": 133.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 167.0, 166.0, 168.0, 174.0, 164.0, 162.0, 167.0], "value": 165.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 74.0, 105.0, 75.0, 78.0, 76.0, 75.0, 92.0, 76.0], "value": 80.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 106.0, 84.0, 84.0, 84.0, 97.0, 84.0, 83.0, 109.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 113.0, 115.0, 114.0, 114.0, 115.0, 113.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 155.0, 152.0, 153.0, 153.0, 151.0, 150.0, 149.0, 149.0], "value": 151.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 60.0, 56.0, 55.0, 57.0, 55.0, 58.0, 56.0, 56.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 56.0, 56.0, 54.0, 56.0, 56.0, 58.0, 56.0], "value": 56.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 86.0, 88.0, 89.0, 87.0, 89.0, 87.0, 116.0, 87.0], "value": 90.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 135.0, 135.0, 133.0, 136.0, 141.0, 130.0, 139.0, 143.0], "value": 136.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 197.0, 196.0, 195.0, 193.0, 200.0, 210.0, 195.0, 195.0, 191.0], "value": 196.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 72.0, 73.0, 75.0, 71.0, 71.0, 76.0, 72.0, 72.0], "value": 73.2, "unit": "score"}]}]} 19:01:23 INFO - Return code: 0 19:01:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:01:23 INFO - # TBPL SUCCESS # 19:01:23 INFO - Running post-action listener: _resource_record_post_action 19:01:23 INFO - [mozharness: 2017-06-02 02:01:23.528819Z] Finished run-tests step (success) 19:01:23 INFO - Running post-run listener: _resource_record_post_run 19:01:23 INFO - Total resource usage - Wall time: 1257s; CPU: 13.0%; Read bytes: 4096; Write bytes: 411095040; Read time: 16; Write time: 281248 19:01:23 INFO - TinderboxPrint: CPU usage
12.7% 19:01:23 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 19:01:23 INFO - TinderboxPrint: I/O write bytes / time
411,095,040 / 281,248 19:01:23 INFO - TinderboxPrint: CPU idle
8,760.7 (87.3%) 19:01:23 INFO - TinderboxPrint: CPU user
1,220.4 (12.2%) 19:01:23 INFO - TinderboxPrint: Swap in / out
0 / 0 19:01:23 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 95576064; Read time: 0; Write time: 78588 19:01:23 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 19:01:23 INFO - run-tests - Wall time: 1242s; CPU: 13.0%; Read bytes: 0; Write bytes: 315097088; Read time: 0; Write time: 202660 19:01:24 INFO - Running post-run listener: _upload_blobber_files 19:01:24 INFO - Blob upload gear active. 19:01:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:01:24 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 19:01:24 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'] 19:01:24 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 19:01:24 INFO - (blobuploader) - INFO - Open directory for files ... 19:01:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:01:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:01:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:01:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:01:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:01:28 INFO - (blobuploader) - INFO - Done attempting. 19:01:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:01:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:01:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:01:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:01:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:01:29 INFO - (blobuploader) - INFO - Done attempting. 19:01:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:01:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:01:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:01:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:01:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:01:30 INFO - (blobuploader) - INFO - Done attempting. 19:01:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:01:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:01:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:01:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:01:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:01:30 INFO - (blobuploader) - INFO - Done attempting. 19:01:30 INFO - (blobuploader) - INFO - Iteration through files over. 19:01:30 INFO - Return code: 0 19:01:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:01:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:01:30 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af72f1323c4c5524d7ab778630d03abcf2b9fc6b09e3e091279dd3904236bdc2b4c77693dce3e382b6eb827ef695346367249f0a5aed694ef5ee38900b96bb2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6e50ec7b735bcb86b6cb59048df1507b19dbb9d5df2096261cd8900b71422a83c9b08a96cc9b41695fcce1e8b73e4fefc1868fa7713585c2d311d3c5917d039", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f78d008769ba33d3b88a97149a8cf5a5602ccc7e2b3396ba83d1db5cac78e0ded3503ac360611d5f5561a2ce7ef213fa97d98634c66016c8958f01a8f78a6e17", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/271e8d3e50d872763904907a6f534b6bd22bed6be551e04c02c2364beaf997df1d61c215143ac9bf1332af6f2b55b538d71017943838b9cdb80a58493225f5c9"} 19:01:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:01:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:01:30 INFO - Contents: 19:01:30 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af72f1323c4c5524d7ab778630d03abcf2b9fc6b09e3e091279dd3904236bdc2b4c77693dce3e382b6eb827ef695346367249f0a5aed694ef5ee38900b96bb2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6e50ec7b735bcb86b6cb59048df1507b19dbb9d5df2096261cd8900b71422a83c9b08a96cc9b41695fcce1e8b73e4fefc1868fa7713585c2d311d3c5917d039", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f78d008769ba33d3b88a97149a8cf5a5602ccc7e2b3396ba83d1db5cac78e0ded3503ac360611d5f5561a2ce7ef213fa97d98634c66016c8958f01a8f78a6e17", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/271e8d3e50d872763904907a6f534b6bd22bed6be551e04c02c2364beaf997df1d61c215143ac9bf1332af6f2b55b538d71017943838b9cdb80a58493225f5c9"} 19:01:30 INFO - Running post-run listener: copy_logs_to_upload_dir 19:01:30 INFO - Copying logs to upload dir... 19:01:30 INFO - mkdir: /builds/slave/test/build/upload/logs 19:01:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1322.020856 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 2 secs) (at 2017-06-01 19:01:30.722745) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-01 19:01:30.726899) ========= 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=438111f3d31ce799eff2119d000001bc-1496366126.471363-2005779219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af72f1323c4c5524d7ab778630d03abcf2b9fc6b09e3e091279dd3904236bdc2b4c77693dce3e382b6eb827ef695346367249f0a5aed694ef5ee38900b96bb2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6e50ec7b735bcb86b6cb59048df1507b19dbb9d5df2096261cd8900b71422a83c9b08a96cc9b41695fcce1e8b73e4fefc1868fa7713585c2d311d3c5917d039", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f78d008769ba33d3b88a97149a8cf5a5602ccc7e2b3396ba83d1db5cac78e0ded3503ac360611d5f5561a2ce7ef213fa97d98634c66016c8958f01a8f78a6e17", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/271e8d3e50d872763904907a6f534b6bd22bed6be551e04c02c2364beaf997df1d61c215143ac9bf1332af6f2b55b538d71017943838b9cdb80a58493225f5c9"} build_url:https://queue.taskcluster.net/v1/task/M01p551nRICde_z2WO7G_w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011168 build_url: 'https://queue.taskcluster.net/v1/task/M01p551nRICde_z2WO7G_w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af72f1323c4c5524d7ab778630d03abcf2b9fc6b09e3e091279dd3904236bdc2b4c77693dce3e382b6eb827ef695346367249f0a5aed694ef5ee38900b96bb2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6e50ec7b735bcb86b6cb59048df1507b19dbb9d5df2096261cd8900b71422a83c9b08a96cc9b41695fcce1e8b73e4fefc1868fa7713585c2d311d3c5917d039", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f78d008769ba33d3b88a97149a8cf5a5602ccc7e2b3396ba83d1db5cac78e0ded3503ac360611d5f5561a2ce7ef213fa97d98634c66016c8958f01a8f78a6e17", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/271e8d3e50d872763904907a6f534b6bd22bed6be551e04c02c2364beaf997df1d61c215143ac9bf1332af6f2b55b538d71017943838b9cdb80a58493225f5c9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-01 19:01:30.751784) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 19:01:30.752115) ========= 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=438111f3d31ce799eff2119d000001bc-1496366126.471363-2005779219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004381 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 19:01:30.835224) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-01 19:01:30.835557) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-01 19:01:30.835868) ========= ========= Total master_lag: 0.18 =========