builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-088 starttime: 1496592626.73 results: success (0) revision: 302eb1670544f4e8d0347de03526c4fd160480e1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-04 09:10:26.730139) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-04 09:10:26.730570) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-04 09:10:26.730990) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-04 09:10:26.765370) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-04 09:10:26.765626) ========= 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=9f7544b6a75ada7b6b576032000001a7-1496587294.882209-355335228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-04 09:10:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 80.8M=0s 2017-06-04 09:10:27 (80.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.177966 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-04 09:10:26.976738) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-04 09:10:26.977082) ========= 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=9f7544b6a75ada7b6b576032000001a7-1496587294.882209-355335228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.059066 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-04 09:10:27.051788) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-04 09:10:27.052141) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 302eb1670544f4e8d0347de03526c4fd160480e1 --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 302eb1670544f4e8d0347de03526c4fd160480e1 --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=9f7544b6a75ada7b6b576032000001a7-1496587294.882209-355335228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-04 09:10:27,177 truncating revision to first 12 chars 2017-06-04 09:10:27,177 Setting DEBUG logging. 2017-06-04 09:10:27,177 attempt 1/10 2017-06-04 09:10:27,177 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/302eb1670544?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-04 09:10:28,290 unpacking tar archive at: mozilla-central-302eb1670544/testing/mozharness/ program finished with exit code 0 elapsedTime=1.433563 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-04 09:10:28.497967) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-04 09:10:28.498240) ========= script_repo_revision: 302eb1670544f4e8d0347de03526c4fd160480e1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-04 09:10:28.498614) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-04 09:10:28.498895) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-04 09:10:28.510443) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2017-06-04 09:10:28.510698) ========= /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=9f7544b6a75ada7b6b576032000001a7-1496587294.882209-355335228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:10:28 INFO - MultiFileLogger online at 20170604 09:10:28 in /builds/slave/test 09:10:28 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 09:10:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:10:28 INFO - {'append_to_log': False, 09:10:28 INFO - 'base_work_dir': '/builds/slave/test', 09:10:28 INFO - 'blob_upload_branch': 'Firefox', 09:10:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:10:28 INFO - 'branch': 'Firefox', 09:10:28 INFO - 'buildbot_json_path': 'buildprops.json', 09:10:28 INFO - 'config_files': ('talos/linux_config.py',), 09:10:28 INFO - 'default_actions': ('clobber', 09:10:28 INFO - 'read-buildbot-config', 09:10:28 INFO - 'download-and-extract', 09:10:28 INFO - 'populate-webroot', 09:10:28 INFO - 'create-virtualenv', 09:10:28 INFO - 'install', 09:10:28 INFO - 'setup-mitmproxy', 09:10:28 INFO - 'run-tests'), 09:10:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:10:28 INFO - 'download_minidump_stackwalk': True, 09:10:28 INFO - 'download_symbols': 'ondemand', 09:10:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:10:28 INFO - 'tooltool.py': '/tools/tooltool.py', 09:10:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:10:28 INFO - '/tools/misc-python/virtualenv.py')}, 09:10:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:10:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:10:28 INFO - 'gecko_profile': False, 09:10:28 INFO - 'gecko_profile_interval': 0, 09:10:28 INFO - 'installer_path': 'installer.exe', 09:10:28 INFO - 'log_level': 'info', 09:10:28 INFO - 'log_name': 'talos', 09:10:28 INFO - 'log_to_console': True, 09:10:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:10:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:10:28 INFO - 'opt_config_files': (), 09:10:28 INFO - 'pip_index': False, 09:10:28 INFO - 'suite': 'dromaeojs-e10s', 09:10:28 INFO - 'system_bits': '32', 09:10:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:10:28 INFO - 'title': 'talos-linux64-ix-088', 09:10:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:10:28 INFO - 'use_talos_json': True, 09:10:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:10:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:10:28 INFO - 'work_dir': 'build'} 09:10:28 INFO - [mozharness: 2017-06-04 16:10:28.855739Z] Running clobber step. 09:10:28 INFO - Running pre-action listener: _resource_record_pre_action 09:10:28 INFO - Running main action method: clobber 09:10:28 INFO - rmtree: /builds/slave/test/build 09:10:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:10:31 INFO - Running post-action listener: _resource_record_post_action 09:10:31 INFO - [mozharness: 2017-06-04 16:10:31.059640Z] Finished clobber step (success) 09:10:31 INFO - [mozharness: 2017-06-04 16:10:31.059762Z] Running read-buildbot-config step. 09:10:31 INFO - Running pre-action listener: _resource_record_pre_action 09:10:31 INFO - Running main action method: read_buildbot_config 09:10:31 INFO - Using buildbot properties: 09:10:31 INFO - { 09:10:31 INFO - "project": "", 09:10:31 INFO - "product": "firefox", 09:10:31 INFO - "who": "ffxbld@noreply.mozilla.org", 09:10:31 INFO - "installer_path": "public/build/target.tar.bz2", 09:10:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 09:10:31 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:10:31 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 09:10:31 INFO - "stage_platform": "linux64-stylosequential", 09:10:31 INFO - "basedir": "/builds/slave/test", 09:10:31 INFO - "buildnumber": 41, 09:10:31 INFO - "platform": "ubuntu64_hw_styloseq", 09:10:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:10:31 INFO - "slavebuilddir": "test", 09:10:31 INFO - "taskId": "CqNIFK56QviSuaxIVgPOeQ", 09:10:31 INFO - "branch": "mozilla-central", 09:10:31 INFO - "script_repo_revision": "production", 09:10:31 INFO - "revision": "302eb1670544f4e8d0347de03526c4fd160480e1", 09:10:31 INFO - "slavename": "talos-linux64-ix-088", 09:10:31 INFO - "repo_path": "mozilla-central" 09:10:31 INFO - } 09:10:31 INFO - Finding installer, test and symbols from parent task. 09:10:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CqNIFK56QviSuaxIVgPOeQ'}, attempt #1 09:10:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CqNIFK56QviSuaxIVgPOeQ'}, attempt #1 09:10:31 INFO - Task dependencies: furA-O8fRNWCXibHPkuJPA 09:10:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/furA-O8fRNWCXibHPkuJPA'}, attempt #1 09:10:32 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/furA-O8fRNWCXibHPkuJPA/artifacts/public/build/target.tar.bz2 09:10:32 INFO - Set test_url: https://queue.taskcluster.net/v1/task/furA-O8fRNWCXibHPkuJPA/artifacts/public/build/test_packages.json 09:10:32 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/furA-O8fRNWCXibHPkuJPA/artifacts/public/build/target.crashreporter-symbols.zip 09:10:32 INFO - Running post-action listener: _resource_record_post_action 09:10:32 INFO - [mozharness: 2017-06-04 16:10:32.605074Z] Finished read-buildbot-config step (success) 09:10:32 INFO - [mozharness: 2017-06-04 16:10:32.605297Z] Running download-and-extract step. 09:10:32 INFO - Running pre-action listener: _resource_record_pre_action 09:10:32 INFO - Running main action method: download_and_extract 09:10:32 INFO - mkdir: /builds/slave/test/build/tests 09:10: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')]} 09:10:32 INFO - trying https://queue.taskcluster.net/v1/task/furA-O8fRNWCXibHPkuJPA/artifacts/public/build/target.test_packages.json 09:10:32 INFO - Downloading https://queue.taskcluster.net/v1/task/furA-O8fRNWCXibHPkuJPA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:10:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/furA-O8fRNWCXibHPkuJPA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:10:33 INFO - Downloaded 989 bytes. 09:10:33 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:10:33 INFO - Using the following test package requirements: 09:10:33 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:10:33 INFO - u'common': [u'target.common.tests.zip'], 09:10:33 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:10:33 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:10:33 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:10:33 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:10:33 INFO - u'mozbase': [u'target.common.tests.zip'], 09:10:33 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:10:33 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:10:33 INFO - u'web-platform': [u'target.common.tests.zip', 09:10:33 INFO - u'target.web-platform.tests.tar.gz'], 09:10:33 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:10:33 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:10:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/furA-O8fRNWCXibHPkuJPA/artifacts/public/build/target.common.tests.zip 09:10:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/furA-O8fRNWCXibHPkuJPA/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:10:33 INFO - Fetch https://queue.taskcluster.net/v1/task/furA-O8fRNWCXibHPkuJPA/artifacts/public/build/target.common.tests.zip into memory 09:10:34 INFO - Content-Length response header: 65102420 09:10:34 INFO - Bytes received: 65102420 09:10:46 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:10:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/furA-O8fRNWCXibHPkuJPA/artifacts/public/build/target.common.tests.zip 09:10:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/furA-O8fRNWCXibHPkuJPA/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:10:46 INFO - Fetch https://queue.taskcluster.net/v1/task/furA-O8fRNWCXibHPkuJPA/artifacts/public/build/target.common.tests.zip into memory 09:10:48 INFO - Content-Length response header: 65102420 09:10:48 INFO - Bytes received: 65102420 09:11:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/furA-O8fRNWCXibHPkuJPA/artifacts/public/build/target.talos.tests.zip 09:11:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/furA-O8fRNWCXibHPkuJPA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:11:00 INFO - Fetch https://queue.taskcluster.net/v1/task/furA-O8fRNWCXibHPkuJPA/artifacts/public/build/target.talos.tests.zip into memory 09:11:01 INFO - Content-Length response header: 14447425 09:11:01 INFO - Bytes received: 14447425 09:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:01 INFO - trying https://queue.taskcluster.net/v1/task/furA-O8fRNWCXibHPkuJPA/artifacts/public/build/target.tar.bz2 09:11:01 INFO - Downloading https://queue.taskcluster.net/v1/task/furA-O8fRNWCXibHPkuJPA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:11:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/furA-O8fRNWCXibHPkuJPA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:11:02 INFO - Downloaded 60364291 bytes. 09:11:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/furA-O8fRNWCXibHPkuJPA/artifacts/public/build/target.tar.bz2 09:11:02 INFO - mkdir: /builds/slave/test/properties 09:11:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:11:02 INFO - Writing to file /builds/slave/test/properties/build_url 09:11:02 INFO - Contents: 09:11:02 INFO - build_url:https://queue.taskcluster.net/v1/task/furA-O8fRNWCXibHPkuJPA/artifacts/public/build/target.tar.bz2 09:11:02 INFO - Running post-action listener: _resource_record_post_action 09:11:02 INFO - Running post-action listener: set_extra_try_arguments 09:11:02 INFO - [mozharness: 2017-06-04 16:11:02.643901Z] Finished download-and-extract step (success) 09:11:02 INFO - [mozharness: 2017-06-04 16:11:02.643999Z] Running populate-webroot step. 09:11:02 INFO - Running pre-action listener: _resource_record_pre_action 09:11:02 INFO - Running main action method: populate_webroot 09:11:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:11:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:11:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:11:02 INFO - '--tppagecycles', 09:11:02 INFO - '7'], 09:11:02 INFO - 'tests': ['tsvgm']}}, 09:11:02 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:11:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:11:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:11:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:11:02 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:11:02 INFO - 'talos_options': ['--disable-e10s'], 09:11:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:11:02 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:11:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:11:02 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:11:02 INFO - 'talos_options': ['--disable-e10s'], 09:11:02 INFO - 'tests': ['damp', 'tps']}, 09:11:02 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:11:02 INFO - 'tests': ['damp', 'tps']}, 09:11:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:11:02 INFO - 'tests': ['dromaeo_dom']}, 09:11:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:11:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:11:02 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:11:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:11:02 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:11:02 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:11:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:11:02 INFO - 'tests': ['a11yr', 09:11:02 INFO - 'ts_paint', 09:11:02 INFO - 'tpaint', 09:11:02 INFO - 'sessionrestore', 09:11:02 INFO - 'sessionrestore_no_auto_restore', 09:11:02 INFO - 'tabpaint']}, 09:11:02 INFO - 'other-e10s': {'tests': ['a11yr', 09:11:02 INFO - 'ts_paint', 09:11:02 INFO - 'tpaint', 09:11:02 INFO - 'sessionrestore', 09:11:02 INFO - 'sessionrestore_no_auto_restore', 09:11:02 INFO - 'tabpaint']}, 09:11:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:11:02 INFO - 'ts_paint', 09:11:02 INFO - 'tpaint', 09:11:02 INFO - 'sessionrestore', 09:11:02 INFO - 'sessionrestore_no_auto_restore', 09:11:02 INFO - 'tabpaint']}, 09:11:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:11:02 INFO - 'ts_paint', 09:11:02 INFO - 'tpaint', 09:11:02 INFO - 'sessionrestore', 09:11:02 INFO - 'sessionrestore_no_auto_restore', 09:11:02 INFO - 'tabpaint']}, 09:11:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:11:02 INFO - 'tests': ['a11yr', 09:11:02 INFO - 'ts_paint', 09:11:02 INFO - 'tpaint', 09:11:02 INFO - 'sessionrestore', 09:11:02 INFO - 'sessionrestore_no_auto_restore', 09:11:02 INFO - 'tabpaint']}, 09:11:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:11:02 INFO - 'tests': ['a11yr', 09:11:02 INFO - 'ts_paint', 09:11:02 INFO - 'tpaint', 09:11:02 INFO - 'sessionrestore', 09:11:02 INFO - 'sessionrestore_no_auto_restore', 09:11:02 INFO - 'tabpaint']}, 09:11:02 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:11:02 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:11:02 INFO - 'bloom_basic_ref']}, 09:11:02 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 09:11:02 INFO - 'talos_options': ['--mitmproxy', 09:11:02 INFO - 'mitmproxy-recording-1.mp', 09:11:02 INFO - '--firstNonBlankPaint'], 09:11:02 INFO - 'tests': ['Quantum_1']}, 09:11:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:11:02 INFO - 'tests': ['tsvgx', 09:11:02 INFO - 'tsvgr_opacity', 09:11:02 INFO - 'tart', 09:11:02 INFO - 'tscrollx', 09:11:02 INFO - 'cart', 09:11:02 INFO - 'tsvg_static']}, 09:11:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:11:02 INFO - 'tsvgr_opacity', 09:11:02 INFO - 'tart', 09:11:02 INFO - 'tscrollx', 09:11:02 INFO - 'cart', 09:11:02 INFO - 'tsvg_static']}, 09:11:02 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:11:02 INFO - 'talos_options': ['--disable-e10s'], 09:11:02 INFO - 'tests': ['tp5o']}, 09:11:02 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:11:02 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:11:02 INFO - 'talos_options': ['--disable-e10s', 09:11:02 INFO - '--xperf_path', 09:11:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:11:02 INFO - 'tests': ['tp5n']}, 09:11:02 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:11:02 INFO - 'talos_options': ['--xperf_path', 09:11:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:11:02 INFO - 'tests': ['tp5n']}}, 09:11:02 INFO - 'talos.zip': {'path': '', 09:11:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:11:02 INFO - Running post-action listener: _resource_record_post_action 09:11:02 INFO - [mozharness: 2017-06-04 16:11:02.658422Z] Finished populate-webroot step (success) 09:11:02 INFO - [mozharness: 2017-06-04 16:11:02.658512Z] Running create-virtualenv step. 09:11:02 INFO - Running pre-action listener: _resource_record_pre_action 09:11:02 INFO - Running main action method: create_virtualenv 09:11:02 INFO - Creating virtualenv /builds/slave/test/build/venv 09:11:02 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 09:11:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:11:02 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:11:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:11:02 INFO - Using real prefix '/usr' 09:11:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:11:03 INFO - Installing distribute.............................................................................................................................................................................................done. 09:11:05 INFO - Installing pip.................done. 09:11:05 INFO - Return code: 0 09:11:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:11:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:11:05 INFO - Reading from file tmpfile_stdout 09:11:05 INFO - Output received: 09:11:05 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) 09:11:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:11:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:05 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 0x18843b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c02dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bff840>, '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 0x1c00740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c00bd0>, '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': '9f7544b6a75ada7b6b576032000001a7-1496587294.882209-355335228', '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 09:11:05 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 09:11:05 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 09:11:05 INFO - Using env: {'DISPLAY': ':0', 09:11:05 INFO - 'HOME': '/home/cltbld', 09:11:05 INFO - 'LANG': 'en_US.UTF-8', 09:11:05 INFO - 'LANGUAGE': 'en_US:en', 09:11:05 INFO - 'LOGNAME': 'cltbld', 09:11:05 INFO - 'MAIL': '/var/mail/cltbld', 09:11:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:05 INFO - 'MOZ_NO_REMOTE': '1', 09:11:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:05 INFO - 'NO_EM_RESTART': '1', 09:11:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:05 INFO - 'PWD': '/builds/slave/test', 09:11:05 INFO - 'SHELL': '/bin/bash', 09:11:05 INFO - 'SHLVL': '1', 09:11:05 INFO - 'TERM': 'linux', 09:11:05 INFO - 'TMOUT': '86400', 09:11:05 INFO - 'USER': 'cltbld', 09:11:05 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1496587294.882209-355335228', 09:11:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:05 INFO - '_': '/tools/buildbot/bin/python'} 09:11:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:05 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 09:11:05 INFO - Cleaning up... 09:11:05 INFO - Return code: 0 09:11:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:11:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:05 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 0x18843b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c02dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bff840>, '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 0x1c00740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c00bd0>, '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': '9f7544b6a75ada7b6b576032000001a7-1496587294.882209-355335228', '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 09:11:05 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 09:11:05 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 09:11:05 INFO - Using env: {'DISPLAY': ':0', 09:11:05 INFO - 'HOME': '/home/cltbld', 09:11:05 INFO - 'LANG': 'en_US.UTF-8', 09:11:05 INFO - 'LANGUAGE': 'en_US:en', 09:11:05 INFO - 'LOGNAME': 'cltbld', 09:11:05 INFO - 'MAIL': '/var/mail/cltbld', 09:11:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:05 INFO - 'MOZ_NO_REMOTE': '1', 09:11:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:05 INFO - 'NO_EM_RESTART': '1', 09:11:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:05 INFO - 'PWD': '/builds/slave/test', 09:11:05 INFO - 'SHELL': '/bin/bash', 09:11:05 INFO - 'SHLVL': '1', 09:11:05 INFO - 'TERM': 'linux', 09:11:05 INFO - 'TMOUT': '86400', 09:11:05 INFO - 'USER': 'cltbld', 09:11:05 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1496587294.882209-355335228', 09:11:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:05 INFO - '_': '/tools/buildbot/bin/python'} 09:11:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:06 INFO - Downloading/unpacking psutil>=3.1.1 09:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:11:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:11:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:11:07 INFO - Installing collected packages: psutil 09:11:07 INFO - Running setup.py install for psutil 09:11:07 INFO - building 'psutil._psutil_linux' extension 09:11:07 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 09:11:08 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 09:11:08 INFO - building 'psutil._psutil_posix' extension 09:11:08 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 09:11:08 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 09:11:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:11:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:11:08 INFO - Successfully installed psutil 09:11:08 INFO - Cleaning up... 09:11:08 INFO - Return code: 0 09:11:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:11:08 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')]} 09:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:08 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')]} 09:11:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:08 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 0x18843b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c02dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bff840>, '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 0x1c00740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c00bd0>, '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': '9f7544b6a75ada7b6b576032000001a7-1496587294.882209-355335228', '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 09:11:08 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 09:11:08 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 09:11:08 INFO - Using env: {'DISPLAY': ':0', 09:11:08 INFO - 'HOME': '/home/cltbld', 09:11:08 INFO - 'LANG': 'en_US.UTF-8', 09:11:08 INFO - 'LANGUAGE': 'en_US:en', 09:11:08 INFO - 'LOGNAME': 'cltbld', 09:11:08 INFO - 'MAIL': '/var/mail/cltbld', 09:11:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:08 INFO - 'MOZ_NO_REMOTE': '1', 09:11:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:08 INFO - 'NO_EM_RESTART': '1', 09:11:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:08 INFO - 'PWD': '/builds/slave/test', 09:11:08 INFO - 'SHELL': '/bin/bash', 09:11:08 INFO - 'SHLVL': '1', 09:11:08 INFO - 'TERM': 'linux', 09:11:08 INFO - 'TMOUT': '86400', 09:11:08 INFO - 'USER': 'cltbld', 09:11:08 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1496587294.882209-355335228', 09:11:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:08 INFO - '_': '/tools/buildbot/bin/python'} 09:11:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:11:08 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 09:11:08 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 09:11:08 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 09:11:08 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 09:11:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:11:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:11:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:11:09 INFO - Installing collected packages: mozsystemmonitor 09:11:09 INFO - Running setup.py install for mozsystemmonitor 09:11:10 INFO - Successfully installed mozsystemmonitor 09:11:10 INFO - Cleaning up... 09:11:10 INFO - Return code: 0 09:11:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:11:10 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')]} 09:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:10 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')]} 09:11:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:10 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 0x18843b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c02dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bff840>, '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 0x1c00740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c00bd0>, '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': '9f7544b6a75ada7b6b576032000001a7-1496587294.882209-355335228', '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 09:11:10 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 09:11:10 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 09:11:10 INFO - Using env: {'DISPLAY': ':0', 09:11:10 INFO - 'HOME': '/home/cltbld', 09:11:10 INFO - 'LANG': 'en_US.UTF-8', 09:11:10 INFO - 'LANGUAGE': 'en_US:en', 09:11:10 INFO - 'LOGNAME': 'cltbld', 09:11:10 INFO - 'MAIL': '/var/mail/cltbld', 09:11:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:10 INFO - 'MOZ_NO_REMOTE': '1', 09:11:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:10 INFO - 'NO_EM_RESTART': '1', 09:11:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:10 INFO - 'PWD': '/builds/slave/test', 09:11:10 INFO - 'SHELL': '/bin/bash', 09:11:10 INFO - 'SHLVL': '1', 09:11:10 INFO - 'TERM': 'linux', 09:11:10 INFO - 'TMOUT': '86400', 09:11:10 INFO - 'USER': 'cltbld', 09:11:10 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1496587294.882209-355335228', 09:11:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:10 INFO - '_': '/tools/buildbot/bin/python'} 09:11:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:10 INFO - Downloading/unpacking jsonschema==2.5.1 09:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:11:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:11: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 09:11: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 09:11: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 09:11: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 09:11:11 INFO - Downloading functools32-3.2.3-2.tar.gz 09:11:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:11:11 INFO - warning: no files found matching '*.txt' 09:11:11 INFO - no previously-included directories found matching 'build' 09:11:11 INFO - no previously-included directories found matching 'dist' 09:11:11 INFO - no previously-included directories found matching '.git*' 09:11:11 INFO - Installing collected packages: jsonschema, functools32 09:11:11 INFO - Running setup.py install for functools32 09:11:11 INFO - warning: no files found matching '*.txt' 09:11:11 INFO - no previously-included directories found matching 'build' 09:11:11 INFO - no previously-included directories found matching 'dist' 09:11:11 INFO - no previously-included directories found matching '.git*' 09:11:11 INFO - Successfully installed jsonschema functools32 09:11:11 INFO - Cleaning up... 09:11:11 INFO - Return code: 0 09:11:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:11: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')]} 09:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11: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')]} 09:11:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11: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', '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 0x18843b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c02dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bff840>, '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 0x1c00740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c00bd0>, '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': '9f7544b6a75ada7b6b576032000001a7-1496587294.882209-355335228', '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 09:11: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:11: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 functools32==3.2.3-2 09:11:11 INFO - Using env: {'DISPLAY': ':0', 09:11:11 INFO - 'HOME': '/home/cltbld', 09:11:11 INFO - 'LANG': 'en_US.UTF-8', 09:11:11 INFO - 'LANGUAGE': 'en_US:en', 09:11:11 INFO - 'LOGNAME': 'cltbld', 09:11:11 INFO - 'MAIL': '/var/mail/cltbld', 09:11:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:11 INFO - 'MOZ_NO_REMOTE': '1', 09:11:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:11 INFO - 'NO_EM_RESTART': '1', 09:11:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:11 INFO - 'PWD': '/builds/slave/test', 09:11:11 INFO - 'SHELL': '/bin/bash', 09:11:11 INFO - 'SHLVL': '1', 09:11:11 INFO - 'TERM': 'linux', 09:11:11 INFO - 'TMOUT': '86400', 09:11:11 INFO - 'USER': 'cltbld', 09:11:11 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1496587294.882209-355335228', 09:11:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:11 INFO - '_': '/tools/buildbot/bin/python'} 09:11:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:11:11 INFO - Cleaning up... 09:11:11 INFO - Return code: 0 09:11:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:11: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')]} 09:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11: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')]} 09:11:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:12 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 0x18843b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c02dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bff840>, '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 0x1c00740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c00bd0>, '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': '9f7544b6a75ada7b6b576032000001a7-1496587294.882209-355335228', '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 09:11:12 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 09:11:12 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 09:11:12 INFO - Using env: {'DISPLAY': ':0', 09:11:12 INFO - 'HOME': '/home/cltbld', 09:11:12 INFO - 'LANG': 'en_US.UTF-8', 09:11:12 INFO - 'LANGUAGE': 'en_US:en', 09:11:12 INFO - 'LOGNAME': 'cltbld', 09:11:12 INFO - 'MAIL': '/var/mail/cltbld', 09:11:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:12 INFO - 'MOZ_NO_REMOTE': '1', 09:11:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:12 INFO - 'NO_EM_RESTART': '1', 09:11:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:12 INFO - 'PWD': '/builds/slave/test', 09:11:12 INFO - 'SHELL': '/bin/bash', 09:11:12 INFO - 'SHLVL': '1', 09:11:12 INFO - 'TERM': 'linux', 09:11:12 INFO - 'TMOUT': '86400', 09:11:12 INFO - 'USER': 'cltbld', 09:11:12 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1496587294.882209-355335228', 09:11:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:12 INFO - '_': '/tools/buildbot/bin/python'} 09:11:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:12 INFO - Downloading/unpacking blobuploader==1.2.4 09:11:12 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 09:11:12 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 09:11:12 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 09:11:12 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 09:11:13 INFO - Downloading blobuploader-1.2.4.tar.gz 09:11:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:11:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:11: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 09:11: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 09:11: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 09:11: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 09:11:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:11:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:11: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 09:11: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 09:11: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 09:11: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 09:11:13 INFO - Downloading docopt-0.6.1.tar.gz 09:11:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:11:13 INFO - Installing collected packages: blobuploader, requests, docopt 09:11:13 INFO - Running setup.py install for blobuploader 09:11:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:11:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:11:13 INFO - Running setup.py install for requests 09:11:14 INFO - Running setup.py install for docopt 09:11:14 INFO - Successfully installed blobuploader requests docopt 09:11:14 INFO - Cleaning up... 09:11:14 INFO - Return code: 0 09:11:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:11: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')]} 09:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11: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')]} 09:11:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:14 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 0x18843b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c02dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bff840>, '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 0x1c00740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c00bd0>, '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': '9f7544b6a75ada7b6b576032000001a7-1496587294.882209-355335228', '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 09:11:14 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 09:11:14 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 09:11:14 INFO - Using env: {'DISPLAY': ':0', 09:11:14 INFO - 'HOME': '/home/cltbld', 09:11:14 INFO - 'LANG': 'en_US.UTF-8', 09:11:14 INFO - 'LANGUAGE': 'en_US:en', 09:11:14 INFO - 'LOGNAME': 'cltbld', 09:11:14 INFO - 'MAIL': '/var/mail/cltbld', 09:11:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:14 INFO - 'MOZ_NO_REMOTE': '1', 09:11:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:14 INFO - 'NO_EM_RESTART': '1', 09:11:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:14 INFO - 'PWD': '/builds/slave/test', 09:11:14 INFO - 'SHELL': '/bin/bash', 09:11:14 INFO - 'SHLVL': '1', 09:11:14 INFO - 'TERM': 'linux', 09:11:14 INFO - 'TMOUT': '86400', 09:11:14 INFO - 'USER': 'cltbld', 09:11:14 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1496587294.882209-355335228', 09:11:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:14 INFO - '_': '/tools/buildbot/bin/python'} 09:11:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:11:14 INFO - Running setup.py (path:/tmp/pip-Srcmid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:11:14 INFO - Running setup.py (path:/tmp/pip-aB3gD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:11:14 INFO - Running setup.py (path:/tmp/pip-nl0btC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:11:14 INFO - Running setup.py (path:/tmp/pip-R57YQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:11:14 INFO - Running setup.py (path:/tmp/pip-yLXLOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:11:15 INFO - Running setup.py (path:/tmp/pip-j8AOHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:11:15 INFO - Running setup.py (path:/tmp/pip-PrGBGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:11:15 INFO - Running setup.py (path:/tmp/pip-NAE4ah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:11:15 INFO - Running setup.py (path:/tmp/pip-J7I7Ro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:11:15 INFO - Running setup.py (path:/tmp/pip-JZ7UR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:11:15 INFO - Running setup.py (path:/tmp/pip-XC9k0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:11:15 INFO - Running setup.py (path:/tmp/pip-DIBfUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:11:15 INFO - Running setup.py (path:/tmp/pip-TZR07t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:11:15 INFO - Running setup.py (path:/tmp/pip-QNRFC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:15 INFO - Running setup.py (path:/tmp/pip-Rf69rY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:11:15 INFO - Running setup.py (path:/tmp/pip-85m0i2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:11:15 INFO - Running setup.py (path:/tmp/pip-6mGABO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:11:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:11:15 INFO - Running setup.py install for manifestparser 09:11:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:11:16 INFO - Running setup.py install for mozcrash 09:11:16 INFO - Running setup.py install for mozdebug 09:11:16 INFO - Running setup.py install for mozdevice 09:11:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:11:16 INFO - Running setup.py install for mozfile 09:11:16 INFO - Running setup.py install for mozhttpd 09:11:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:11:16 INFO - Running setup.py install for mozinfo 09:11:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:11:16 INFO - Running setup.py install for mozInstall 09:11:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:11:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:11:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:11:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:11:16 INFO - Running setup.py install for mozleak 09:11:16 INFO - Running setup.py install for mozlog 09:11:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:11:16 INFO - Running setup.py install for moznetwork 09:11:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:11:17 INFO - Running setup.py install for mozprocess 09:11:17 INFO - Running setup.py install for mozprofile 09:11:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:11:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:11:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:11:17 INFO - Running setup.py install for mozrunner 09:11:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:11:17 INFO - Running setup.py install for mozscreenshot 09:11:17 INFO - Running setup.py install for moztest 09:11:17 INFO - Running setup.py install for mozversion 09:11:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:11:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:11:17 INFO - Cleaning up... 09:11:17 INFO - Return code: 0 09:11:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:11: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')]} 09:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11: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')]} 09:11:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:17 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 0x18843b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c02dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bff840>, '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 0x1c00740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c00bd0>, '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': '9f7544b6a75ada7b6b576032000001a7-1496587294.882209-355335228', '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 09:11:17 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 09:11:17 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 09:11:17 INFO - Using env: {'DISPLAY': ':0', 09:11:17 INFO - 'HOME': '/home/cltbld', 09:11:17 INFO - 'LANG': 'en_US.UTF-8', 09:11:17 INFO - 'LANGUAGE': 'en_US:en', 09:11:17 INFO - 'LOGNAME': 'cltbld', 09:11:17 INFO - 'MAIL': '/var/mail/cltbld', 09:11:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:17 INFO - 'MOZ_NO_REMOTE': '1', 09:11:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:17 INFO - 'NO_EM_RESTART': '1', 09:11:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:17 INFO - 'PWD': '/builds/slave/test', 09:11:17 INFO - 'SHELL': '/bin/bash', 09:11:17 INFO - 'SHLVL': '1', 09:11:17 INFO - 'TERM': 'linux', 09:11:17 INFO - 'TMOUT': '86400', 09:11:17 INFO - 'USER': 'cltbld', 09:11:17 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1496587294.882209-355335228', 09:11:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:17 INFO - '_': '/tools/buildbot/bin/python'} 09:11:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:11:17 INFO - Running setup.py (path:/tmp/pip-cBe6KP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:11:17 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)) 09:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:11:17 INFO - Running setup.py (path:/tmp/pip-YA_WUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:11:18 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)) 09:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:11:18 INFO - Running setup.py (path:/tmp/pip-4GaTzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:11:18 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)) 09:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:11:18 INFO - Running setup.py (path:/tmp/pip-eh0RJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:11:18 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)) 09:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:11:18 INFO - Running setup.py (path:/tmp/pip-p4YBUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:11:18 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)) 09:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:11:18 INFO - Running setup.py (path:/tmp/pip-mYOaGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:11:18 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)) 09:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:11:18 INFO - Running setup.py (path:/tmp/pip-O1dgG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:11:18 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)) 09:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:11:18 INFO - Running setup.py (path:/tmp/pip-D09SVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:11:18 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)) 09:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:11:18 INFO - Running setup.py (path:/tmp/pip-3UpA0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:11:18 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)) 09:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:11:18 INFO - Running setup.py (path:/tmp/pip-TemRyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:11:18 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)) 09:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:11:18 INFO - Running setup.py (path:/tmp/pip-7OykF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:11:18 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)) 09:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:11:18 INFO - Running setup.py (path:/tmp/pip-SB0lKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:11:18 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)) 09:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:11:18 INFO - Running setup.py (path:/tmp/pip-dV3sXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:11:18 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)) 09:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:11:18 INFO - Running setup.py (path:/tmp/pip-f78g5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:11:18 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)) 09:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:18 INFO - Running setup.py (path:/tmp/pip-caS1O0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:18 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)) 09:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:11:18 INFO - Running setup.py (path:/tmp/pip-HHVTPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:11:19 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)) 09:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:11:19 INFO - Running setup.py (path:/tmp/pip-1L5Sru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:11:19 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)) 09:11:19 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)) 09:11:19 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)) 09:11:19 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)) 09:11:19 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)) 09:11:19 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)) 09:11:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:11:19 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 09:11:19 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 09:11:19 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 09:11:19 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 09:11:20 INFO - Downloading blessings-1.6.tar.gz 09:11:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:11:20 INFO - Installing collected packages: blessings 09:11:20 INFO - Running setup.py install for blessings 09:11:20 INFO - Successfully installed blessings 09:11:20 INFO - Cleaning up... 09:11:20 INFO - Return code: 0 09:11:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:11:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:11:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:11:20 INFO - Reading from file tmpfile_stdout 09:11:20 INFO - Current package versions: 09:11:20 INFO - argparse == 1.2.1 09:11:20 INFO - blessings == 1.6 09:11:20 INFO - blobuploader == 1.2.4 09:11:20 INFO - docopt == 0.6.1 09:11:20 INFO - functools32 == 3.2.3-2 09:11:20 INFO - jsonschema == 2.5.1 09:11:20 INFO - manifestparser == 1.1 09:11:20 INFO - mozInstall == 1.12 09:11:20 INFO - mozcrash == 1.0 09:11:20 INFO - mozdebug == 0.1 09:11:20 INFO - mozdevice == 0.51 09:11:20 INFO - mozfile == 1.2 09:11:20 INFO - mozhttpd == 0.7 09:11:20 INFO - mozinfo == 0.9 09:11:20 INFO - mozleak == 0.1 09:11:20 INFO - mozlog == 3.4 09:11:20 INFO - moznetwork == 0.27 09:11:20 INFO - mozprocess == 0.25 09:11:20 INFO - mozprofile == 0.28 09:11:20 INFO - mozrunner == 6.13 09:11:20 INFO - mozscreenshot == 0.1 09:11:20 INFO - mozsystemmonitor == 0.3 09:11:20 INFO - moztest == 0.8 09:11:20 INFO - mozversion == 1.4 09:11:20 INFO - psutil == 3.1.1 09:11:20 INFO - requests == 1.2.3 09:11:20 INFO - wsgiref == 0.1.2 09:11:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:11: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')]} 09:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11: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')]} 09:11:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:20 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 0x18843b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c02dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bff840>, '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 0x1c00740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c00bd0>, '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': '9f7544b6a75ada7b6b576032000001a7-1496587294.882209-355335228', '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 09:11:20 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 09:11:20 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 09:11:20 INFO - Using env: {'DISPLAY': ':0', 09:11:20 INFO - 'HOME': '/home/cltbld', 09:11:20 INFO - 'LANG': 'en_US.UTF-8', 09:11:20 INFO - 'LANGUAGE': 'en_US:en', 09:11:20 INFO - 'LOGNAME': 'cltbld', 09:11:20 INFO - 'MAIL': '/var/mail/cltbld', 09:11:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:20 INFO - 'MOZ_NO_REMOTE': '1', 09:11:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:20 INFO - 'NO_EM_RESTART': '1', 09:11:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:20 INFO - 'PWD': '/builds/slave/test', 09:11:20 INFO - 'SHELL': '/bin/bash', 09:11:20 INFO - 'SHLVL': '1', 09:11:20 INFO - 'TERM': 'linux', 09:11:20 INFO - 'TMOUT': '86400', 09:11:20 INFO - 'USER': 'cltbld', 09:11:20 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1496587294.882209-355335228', 09:11:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:20 INFO - '_': '/tools/buildbot/bin/python'} 09:11:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:20 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)) 09:11:20 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)) 09:11:20 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)) 09:11:20 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)) 09:11:20 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)) 09:11:20 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)) 09:11:20 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)) 09:11:20 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)) 09:11:20 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)) 09:11:20 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:22 INFO - Downloading marionette_driver-1.4.0.tar.gz 09:11:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 09:11:22 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)) 09:11:22 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)) 09:11:22 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)) 09:11:22 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)) 09:11:22 INFO - Installing collected packages: marionette-driver 09:11:22 INFO - Running setup.py install for marionette-driver 09:11:22 INFO - Successfully installed marionette-driver 09:11:22 INFO - Cleaning up... 09:11:22 INFO - Return code: 0 09:11:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18843b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c02dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bff840>, '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 0x1c00740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c00bd0>, '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': '9f7544b6a75ada7b6b576032000001a7-1496587294.882209-355335228', '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 09:11:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:11:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:11:22 INFO - Using env: {'DISPLAY': ':0', 09:11:22 INFO - 'HOME': '/home/cltbld', 09:11:22 INFO - 'LANG': 'en_US.UTF-8', 09:11:22 INFO - 'LANGUAGE': 'en_US:en', 09:11:22 INFO - 'LOGNAME': 'cltbld', 09:11:22 INFO - 'MAIL': '/var/mail/cltbld', 09:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:22 INFO - 'MOZ_NO_REMOTE': '1', 09:11:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:22 INFO - 'NO_EM_RESTART': '1', 09:11:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:22 INFO - 'PWD': '/builds/slave/test', 09:11:22 INFO - 'SHELL': '/bin/bash', 09:11:22 INFO - 'SHLVL': '1', 09:11:22 INFO - 'TERM': 'linux', 09:11:22 INFO - 'TMOUT': '86400', 09:11:22 INFO - 'USER': 'cltbld', 09:11:22 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1496587294.882209-355335228', 09:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:22 INFO - '_': '/tools/buildbot/bin/python'} 09:11:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:11:22 INFO - Cleaning up... 09:11:22 INFO - Return code: 0 09:11:22 INFO - Running post-action listener: _resource_record_post_action 09:11:22 INFO - Running post-action listener: _start_resource_monitoring 09:11:22 INFO - Starting resource monitoring. 09:11:22 INFO - [mozharness: 2017-06-04 16:11:22.515503Z] Finished create-virtualenv step (success) 09:11:22 INFO - [mozharness: 2017-06-04 16:11:22.516439Z] Running install step. 09:11:22 INFO - Running pre-action listener: _resource_record_pre_action 09:11:22 INFO - Running main action method: install 09:11:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:11:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:11:22 INFO - Reading from file tmpfile_stdout 09:11:22 INFO - Detecting whether we're running mozinstall >=1.0... 09:11:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:11:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:11:22 INFO - Reading from file tmpfile_stdout 09:11:22 INFO - Output received: 09:11:22 INFO - Usage: mozinstall [options] installer 09:11:22 INFO - Options: 09:11:22 INFO - -h, --help show this help message and exit 09:11:22 INFO - -d DEST, --destination=DEST 09:11:22 INFO - Directory to install application into. [default: 09:11:22 INFO - "/builds/slave/test"] 09:11:22 INFO - --app=APP Application being installed. [default: firefox] 09:11:22 INFO - mkdir: /builds/slave/test/build/application 09:11:22 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'] 09:11:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:11:40 INFO - Reading from file tmpfile_stdout 09:11:40 INFO - Output received: 09:11:40 INFO - /builds/slave/test/build/application/firefox/firefox 09:11:40 INFO - Running post-action listener: _resource_record_post_action 09:11:40 INFO - [mozharness: 2017-06-04 16:11:40.259780Z] Finished install step (success) 09:11:40 INFO - [mozharness: 2017-06-04 16:11:40.260060Z] Running setup-mitmproxy step. 09:11:40 INFO - Running pre-action listener: _resource_record_pre_action 09:11:40 INFO - Running main action method: setup_mitmproxy 09:11:40 INFO - Skipping: mitmproxy is not required 09:11:40 INFO - Running post-action listener: _resource_record_post_action 09:11:40 INFO - [mozharness: 2017-06-04 16:11:40.261187Z] Finished setup-mitmproxy step (success) 09:11:40 INFO - [mozharness: 2017-06-04 16:11:40.261407Z] Running run-tests step. 09:11:40 INFO - Running pre-action listener: _resource_record_pre_action 09:11:40 INFO - Running main action method: run_tests 09:11:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:11:40 INFO - Python 2.7.3 09:11:40 INFO - Return code: 0 09:11:40 INFO - grabbing minidump binary from tooltool 09:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:40 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 0x1bff840>, '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 0x1c00740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c00bd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:11:40 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 09:11:40 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 09:11:40 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 09:11:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:11:40 INFO - Return code: 0 09:11:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:11:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:11:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:11:40 INFO - ENV: RUST_BACKTRACE is now 1 09:11:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:11:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:11:40 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/furA-O8fRNWCXibHPkuJPA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-088', '--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 09:11:40 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/furA-O8fRNWCXibHPkuJPA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-088 --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 09:11:40 INFO - Using env: {'DISPLAY': ':0', 09:11:40 INFO - 'HOME': '/home/cltbld', 09:11:40 INFO - 'LANG': 'en_US.UTF-8', 09:11:40 INFO - 'LANGUAGE': 'en_US:en', 09:11:40 INFO - 'LOGNAME': 'cltbld', 09:11:40 INFO - 'MAIL': '/var/mail/cltbld', 09:11:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:11:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:11:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:40 INFO - 'MOZ_NO_REMOTE': '1', 09:11:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:11:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:40 INFO - 'NO_EM_RESTART': '1', 09:11:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:40 INFO - 'PWD': '/builds/slave/test', 09:11:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:11:40 INFO - 'RUST_BACKTRACE': '1', 09:11:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:11:40 INFO - 'SHELL': '/bin/bash', 09:11:40 INFO - 'SHLVL': '1', 09:11:40 INFO - 'TERM': 'linux', 09:11:40 INFO - 'TMOUT': '86400', 09:11:40 INFO - 'USER': 'cltbld', 09:11:40 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1496587294.882209-355335228', 09:11:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:40 INFO - '_': '/tools/buildbot/bin/python'} 09:11:40 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/furA-O8fRNWCXibHPkuJPA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-088', '--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 09:11:40 INFO - mozversion application_buildid: 20170604151807 09:11:40 INFO - mozversion application_changeset: 302eb1670544f4e8d0347de03526c4fd160480e1 09:11:40 INFO - mozversion application_display_name: Nightly 09:11:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:11:40 INFO - mozversion application_name: Firefox 09:11:40 INFO - mozversion application_remotingname: firefox 09:11:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:11:40 INFO - mozversion application_vendor: Mozilla 09:11:40 INFO - mozversion application_version: 55.0a1 09:11:40 INFO - mozversion platform_buildid: 20170604151807 09:11:40 INFO - mozversion platform_changeset: 302eb1670544f4e8d0347de03526c4fd160480e1 09:11:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:11:40 INFO - mozversion platform_version: 55.0a1 09:11:40 INFO - using testdate: 1496592700 09:11:40 INFO - actual date: 1496592700 09:11:40 INFO - starting webserver on 'localhost:48370' 09:11:40 INFO - SUITE-START | Running 2 tests 09:11:40 INFO - TEST-START | dromaeo_css 09:11:40 INFO - operating with platform_type : linux_ 09:11:40 INFO - Initialising browser for dromaeo_css test... 09:11:40 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48370/getInfo.html -profile /tmp/tmpKJDmky/profile 09:11:40 INFO - TEST-INFO | started process 3346 (/builds/slave/test/build/application/firefox/firefox http://localhost:48370/getInfo.html) 09:12:17 INFO - TEST-INFO | 3346: killed by SIGTERM 09:12:17 INFO - Browser initialized. 09:12:17 INFO - Running cycle 1/1 for dromaeo_css test... 09:12:17 INFO - TEST-INFO | started process 3576 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKJDmky/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:12:29 INFO - PID 3576 | RSS: Main: 193687552 09:12:29 INFO - PID 3576 | 09:15:30 INFO - PID 3576 | Cycle 1(1): loaded http://localhost:48370/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48370/tests/dromaeo/cssquery-ext.html) 09:15:31 INFO - PID 3576 | RSS: Main: 188887040 09:15:31 INFO - PID 3576 | 09:18:33 INFO - PID 3576 | Cycle 1(1): loaded http://localhost:48370/tests/dromaeo/cssquery-ext.html (next: http://localhost:48370/tests/dromaeo/cssquery-jquery.html) 09:18:34 INFO - PID 3576 | RSS: Main: 191897600 09:18:34 INFO - PID 3576 | 09:21:35 INFO - PID 3576 | Cycle 1(1): loaded http://localhost:48370/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48370/tests/dromaeo/cssquery-mootools.html) 09:21:36 INFO - PID 3576 | RSS: Main: 191275008 09:21:36 INFO - PID 3576 | 09:24:38 INFO - PID 3576 | Cycle 1(1): loaded http://localhost:48370/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48370/tests/dromaeo/cssquery-prototype.html) 09:24:39 INFO - PID 3576 | RSS: Main: 193708032 09:24:39 INFO - PID 3576 | 09:27:41 INFO - PID 3576 | Cycle 1(1): loaded http://localhost:48370/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48370/tests/dromaeo/cssquery-yui.html) 09:27:42 INFO - PID 3576 | RSS: Main: 194289664 09:27:42 INFO - PID 3576 | 09:30:44 INFO - PID 3576 | Cycle 1(1): loaded http://localhost:48370/tests/dromaeo/cssquery-yui.html (next: http://localhost:48370/tests/dromaeo/cssquery-dojo.html) 09:30:44 INFO - PID 3576 | RSS: Main: 191799296 09:30:44 INFO - PID 3576 | 09:30:44 INFO - PID 3576 | __start_tp_report 09:30:44 INFO - PID 3576 | _x_x_mozilla_page_load 09:30:44 INFO - PID 3576 | _x_x_mozilla_page_load_details 09:30:44 INFO - PID 3576 | |i|pagename|runs| 09:30:44 INFO - PID 3576 | |0;dojo.html;3117.485614873546;3130.7808453408243;3156.4949608062716;3167.952480712789;3179.205198700325;5823.2138661280715;5944.970275148624;5956.404359564041;5957.672328021968;5974.372690867462;5814.360420353758;5879.559033072515;5959.582829201958;6003.339632640417;6026.096085587164;5326.627136100475;5421.376541697716;5442.6462279951875;5481.177823326493;5554.694491802949;5551.1118221084635;5566.304211973504;5576.581756368289;5578.191162281467;5593.916091258634;5400.91898621521;5421.457854214586;5462.945370546323;5470.206820011116;5509.696966666832;5511.090670039439;5531.197976293455;5534.557235421156;5548.5838562108;5548.91676624851;5434.673919564799;5469.234307196995;5474.7262636868;5481.506664400184;5484.149956756709;5806.071028635398;5917.674527900964;5935.821925342247;5943;5955.642661440327;6252.124702541648;6269.811905642838;6375.521835862282;6376.585521941059;6396.680165991682;6442.742290308382;6490;6522.054302126166;6529.281779004354;6531.4448271896945;6019.518438524908;6025.638461692269;6030.457258846681;6050;6057.303410107894;6368;6447.097406363113;6462.547621666438;6546.541742078104;6554.3117972613145;6099.11562823397;6157.415045570753;6164.229471316085;6260.7495700171485;6302.590331628429;6447.838804029937;6462.224533056064;6470.805875823733;6480.222373315232;6484.935150648433;6429.196350456193;6434.388733070351;6439.61362318253;6458.967705161444;6464.709088091047;6195.876082478325;6238.500919926395;6261.9373806262265;6366.395192456709;6443.677816109176;5211.504907033902;5232.215167724872;5234;5245.763940622681;5280.762365693553;4486.2597671383855;4488.326750987378;4494.16857881293;4514.34541991416;4534.9319760203625;5474.507294343528;5552.639078459887;5597.384287728347;5612.989661860823;5632.8028519002455;6360.491160707133;6376.744930202833;6442.613443193423;6453.903191452132;6473.417392434703;5575.414581468968;5575.553955683536;5609.523190528769;5636.60543761941;5658.207850900877;5586.273784408001;5702.344230413472;5711.086226203787;5719.113537401709;5723.170140329712;6039.909401358983;6130.734471166763;6136.079588061826;6225.128482012431;6240.500759939103;6476.060971159061;6503.544751867324;6513;6524.869502609827;6524.934750652433;6258.249010118815;6308.27454842699;6312.652804095819;6315.96842015787;6342.809715708536;6098.250697042061;6179.227596550431;6206.689665516797;6327.873442531031;6343.841403964938;6420.486361091195;6423.7430502781235;6453.064305675744;6458.160439142881;6464.5151613630105;6001.129836173817;6098.390160983866;6216.906746398898;6254.499640028877;6262.5929314594405;6101.731934812904;6197.907031394623;6226.813195604139;6273.466755325666;6277.654728989767;6048.4858787003595;6124.908126378019;6136.549713441251;6188.504919606511;6199.659018754011;6143.235544005126;6193.349698281616;6212.099245609452;6212.390795865657;6289.842753931189;6032.8793424132145;6033.215681961317;6062.454379105901;6098.420650038239;6112.022076467744 09:30:44 INFO - PID 3576 | |1;ext.html;704.5702121705758;728.1262485017978;750.8122969257686;1154.3362566524252;1157.230441756232;34791;35960;36008.63991360089;36413.45379819305;36547.817260913725;38654.420183697264;38823.22353552927;38866.22267554647;38971.22057558847;39082.8045859771;7237.927620723778;7316.341529262365;7430.368418684418;7442.590657513834;7487.101547814243;7316.414686825068;7387.704491820321;7434.330910218079;7464.440166987498;7466.738664146756;7446.962765186194;7447.4786764926475;7472.514286571382;7511.511751736147;7522.887156692654;7362.926370736332;7439.962800185992;7465.104187497481;7468.551886886804;7478.850422991537;7297.708091676326;7305.853882922365;7323.597202153879;7347.155077166088;7349.191588925214;36615.63384366149;36890.631093688986;36915;36933.81533092344;37006.814965925;3525.964740352615;3573.4818451324672;3575.481555174485;3580.856765729368;3583;28094.719052809414;28117.85941070302;28150.296242593893;28304.292392690142;28319.85840070807;3556.697680697144;3587;3591.910202244939;3605.1708107135505;3613.331533666254;141995;144336;157666.21166894207;164186;164606;44065.559344406785;44432.77783611061;44473.33290000653;44487.6653700383;44492.55507444884;45154;45244.32133518;51295;52342.47657523452;52353.47646523486;13645.931770341085;13759.724805504035;13836.377363018688;13852.792208116887;13886.583402497941;10863.51114199863;11019.228653994303;11037.337759734442;11075.667729968114;11132.443377831076;14311.642208944651;14411.207383593794;14532.418703251751;14556.927215363856;14674.55976320712;5867.970660146757;5918.556108291896;5984.940150598525;6017.247844019497;6050.183225264533;969.1132613658565;996.1881066930429;998.4358837256926;1004.322082594246;1011.9898801012043;21405.464863378227;22281.66577501339;22450.550988980456;22772.65841012353;22866.885665571564;1080.6757972608186;1088.3687461272443;1090.2422816142705;1092.9781404371868;1094.496531595475;12066.939665301792;12238.265704057607;12379.381030948416;14710.41158353654;16455.177241138135;202986;203214;203392;203863;204716;54333.185002225;54803.72598136984;54829.72585137129;54886;54971.72514137404;1414.5968399006233;1455.1123814473162;1468.3098943496539;1469.3681716861852;1472.5729538433948;24640.644764538123;25208.36979075538;26705.465890682466;26965.73034269711;27180.32049198786;47839;47845;48103.518964809904;48295.75852120717;48428.7578562119;191913;191983;192700;192719;193183;33687.15782105467;33991.64033438635;34060;34196.65803342034;34301.712285964255;39496;40590.79704601458;42031.3695294577;42141.157176855675;42174.36738448864;29848.552271716377;29992.250193744458;30138.84930575333;30197;31998.52002219922;29430.41139177247;29552.55671164891;30025.849870750506;30085.3982920336;30961;33920.15199620029;34498.82750586231;34556;34613;34615.826920865235;27156.72843271542;28594.714052860036;29345.413091738472;29811.254718632208;30198;23634;24520.386990325384;24659.506809863342;24749.25752227436;24986.250412487654 09:30:44 INFO - PID 3576 | |2;jquery.html;404.98177582008805;415.79002603685143;416.53764321602995;425.4447945431212;437.5952244174138;14672.999999999973;15387.846121538782;20251.49371265717;20931.581368372623;20989.47526311843;21052.263170789025;22066.33800985969;22107.226247081355;22131.225407110753;22139.225127120553;5813.244278243833;5989.88020239595;6009.699515024253;6035.124906888521;6049.032154855224;5888.205092312526;5996.100584912255;6010.27876654802;6018.307894592134;6032.879342413171;5515.09001014832;5782.913256301159;5890.911636325459;5958.553108516857;5970.731317090741;5736.225609542721;5743.885122297552;5783.6529808211435;5794;5798.3911689272445;5214.921776173361;5221.190715439113;5221.71280579568;5235.869103272411;5252.947470525322;25294.74705252961;25336.619950700755;25382.238532844043;25388.238352849443;25444.109456168946;1875.1093230715437;1931.874428162165;1934.1586409911592;1936.738540297056;1943.2712732725229;16023.198840058067;16715.498535043967;16777.916110419494;16833.66332673352;16899.408520701716;2147.6134295826746;2204.680321353411;2248.6964259824877;2250.1224522436264;2250.718660167479;116341;117922.41038794837;118088.40955795338;118739.4063029688;118819;10593.89406105929;11292.378919159524;11369;11455.198136130392;11876;14981.625459363386;14998.925005374904;15018.098914065191;15023.474178403703;15072.472463463726;8170.877436838452;8204.343652507785;8214.4660597061;8236.217559331853;8280.544570048585;7902.209779022051;7911.496815605132;8004.119546849958;8005.799855003672;8040.5979701015885;7252.746153884589;7272.345488906024;7306.415486761046;7393.297636724503;7432.702691892372;1932.304435312731;1937.9612407752047;1950.2199120351972;1962.833159181457;2088.5927244187237;942.6229508196776;959.8314442341762;972.5769290358717;989.6585677941099;993.5181437003048;17879.28482860697;18477.53806154857;18798.812011879978;21528.892355538123;23011.88494057519;984.2962281968427;1011.9696409107738;1016.11090295991;1031.3141760729181;1031.8555402243542;10124.139448146843;10249.538770755335;10466.488042869656;10485.37087774736;10583.25917185805;466861;468314;473190;474327;474865;105225.47387263014;105324;105712.47143764232;107272.63636818128;107647;1203.6328919679581;1209.3953023488257;1247.3887794980576;1248.9437975291316;1260.4013093780563;16064.598385040468;19433.222671093565;20965.37103886886;21386.78613213848;21394.679079813504;51773.48226517686;51868;52271.47728522818;52310.215346769066;53442.73278633582;66696.6665166671;67241.66379168072;68115;68586;68719;15168.620784480476;15584.22078896028;15788.68422631564;15789.131597762233;15805.920970395535;17736.733948990517;17859.642807144046;17884.195211215785;18081.819181808012;18097.909510452362;14229.573112806633;14869.330880110638;15141.621459463602;15197.392104315704;15216.869638250433;12855.87144128584;13376;13431.932840335736;13526.864731352955;13602.591922242349;14255.358508867334;14366.712665746836;14413.927930360282;14466.493672721404;14625.85374146245;15027.219964306638;15119.848801511844;15130.621734456727;15149.318280677617;15166.924165379103;14248;14865.878165585349;14875.256237188314;14933.402663893323;15002.774958375414 09:30:44 INFO - PID 3576 | |3;mootools.html;1299.3568183749046;1360.3606305036635;1372.4235820955198;1375.113052081407;1384.9446022159113;10827.566897324108;11213.775724485515;11357.375344356056;11432.885671143285;11722.23805452645;11503.654890353282;11707;11731.765364692701;11744.588939387124;11776.116791240669;2422.6002709552945;2482.1064416809936;2488.8631125288102;2496.4383013821925;2498.9875050624723;2087.6972838938345;2166.306781829815;2404.9398765030837;2416.4079800448912;2474.393773525489;2446.522928029026;2449.326435230308;2475.356407334088;2476.863772492512;2478.566250906093;2345.1323010486144;2345.8240631952585;2348.694669692929;2354.682117914077;2357.823163262762;2321.071571371448;2326.895289711967;2334.498082912182;2340.508493216427;2346.5306938612175;11191.32852028881;11384.886151138548;11419.54321827126;11433.771324573461;11476.71308217293;6326.87346253077;6505.967470162666;6518.93481065188;6582.736690532373;6588.868222635569;3820.9235815283537;3910.1788624388914;3941.743786653887;4031.093004074089;4038.697097717683;1240.3302216802915;1270.3076823131416;1302.9934850325783;1304.778187708092;1304.8173255744202;16749.497515074567;16928.66142677152;16943.237554310086;16945.915270423568;16946.152692365456;5104.923426148611;5284.815031473957;5292.92060619091;5299.329717202633;5387.488188622075;12368.81446778299;12417.31704756229;12450.501979920882;12456.75086498283;12563.748725025449;6252.187215661935;6392.3927226913365;6442.48460123189;6451.451626611791;6455.128557644658;5858.794942177088;5977.252843394575;5978.133170690226;5979.611325263844;6054.939450605438;4213.747175169499;4320.783960801948;4366.170427618742;4369.584889435499;4390.780460976938;1228.2753175626424;1267.353649638691;1298.0783643612951;1300.1548993154524;1300.6293206436121;880.3969281042379;880.7137680253943;919.5172534419484;931.1293940165966;941.3363578677016;6923.861522769617;7038.894416583756;7222.711091556384;7351.926480735231;7624.961875190588;925.153484561632;979.5200351827554;979.8089372572423;993.1955116355775;995.8008398320364;4573.291139873325;4790.161721698759;4854.368932038883;5010.498950105033;5012.147934851084;13823;14632.926835365968;14659.706805863823;14817.333220005126;14861.479848205478;14388.856111438961;14554.41782328695;14662.413503459742;14726;14784.852151478563;8920.330975176888;8998.370114091951;9077;9144.817103658022;9174.770630734152;6659.044887756545;6984.511084224056;7236.565806051653;7285.927140728525;7472;13240.271785051915;13287.867121329049;13316.800247996482;13416.39626216842;13617.140400516002;13565;13580.592582222549;13723.794143088062;13765.793513097511;13807.378667959765;9508.28687848428;9759.072888075621;9796;9811.558479868565;9826.901730982885;9585.952070239604;10721.892781072402;10728.624498142528;10866.511007004545;10879.129669626569;8717.346199035224;9131.223845972901;9283.35016548862;9446.29152813528;9476.336656433983;9145.268378529569;9150.725478235663;9180.540972951192;9291.72124836256;9312.953435232781;8170.142135075732;8185.918140818516;8255.545944973084;8256;8268.958655206685;6043.214382130295;6138.723757430837;6318.273398559225;6348.714307856065;6440.516961227833;6319.526035547445;6380.9361906380345;6497.545171837926;6725.865482690417;6758.222804377559 09:30:44 INFO - PID 3576 | |4;prototype.html;377.44138674761354;389.73498021345483;393.40595700492247;396.0356531844956;398.2473125792253;6035.9698201509045;6257.468115210213;6278.529110316727;6312.769010043044;6346.4288214060725;5947.791827286046;5973.506623344164;6018.277806663195;6065.757369705218;6080;4746.976265118669;4747.881302967419;4748.8575342739605;4749.572538471537;4775.474697783241;4752.7861246244;4762.857114286577;4766.833160839371;4773.260144677581;4774;4707.45864225615;4715.575598196162;4717.69334993226;4736.171170045245;4741.478437371887;4675.88310292242;4725.243960966263;4726.692764970266;4734.715917044971;4736.289556566542;4124.938125928114;4127.607877251657;4129.421880936671;4138.337865941465;4149.854755083557;5966.820995370146;5979.146464595946;6014.3985601439945;6029.879402411971;6035.155078289043;5432.2123292122815;5456.127019676833;5457.918131228034;5459.617826752129;5472.315960504937;6301.14934483848;6328.968355158241;6337.461315788163;6340.207474065742;6340.682965851689;4505.189065968125;4505.324201369788;4514.706544074657;4529.954700452986;4531.546845315475;6467.191601049869;6579.848526507842;6727.461803055793;6834.9658251708925;6953.341261354904;4542.500324964251;4574.656900732459;4579.656525760514;4583.702059366131;4593.517680643551;4589.852536865784;4591.242444996605;4633.911030907734;4643.95356046442;4670.626349892001;5243.449437809051;5397.190421436738;5403.270558474555;5405.459454054641;5410.675359478365;6472.773452929125;6524.380183882524;6544.54188206821;6568.146141001639;6593.439557637655;1601.3674598533514;1605.6868910562328;1608.766728824314;1610.15466879889;1612.2261314569073;1024.2267088348249;1070.4594179939236;1071.1056268016293;1083.7832433513172;1086.8805130715375;5846.561507886926;5869.413058694096;5870.236869206976;5875.030619947746;5901.557383196277;6808.353206445379;6809.965950170217;6826.658667066627;6829.965850170717;6846.007328937276;5777.422257774273;5790.478856902899;5799.971000144972;5807.5063619591965;5826.446487583673;3571.142925697814;3584.8386822593047;3597.568291805;3604.9098772530897;3610.8736194233074;6576.769813056616;6594.934050659432;6595.505337099737;6596.868062638816;6603.042558828943;6896;6919.930800691928;6925.480588955848;6929.480288978347;6941.548799328028;6523;6546.672666366758;6555.344465553407;6568.605883647092;6577.934220657828;6809.38715515606;6832.369537727911;6838.04267402574;6846.452283817183;6850.417714494324;6680.6283769263155;6711.832204194934;6718.966405167943;6722.327767223239;6724.226713927961;6268.373162683877;6526.282108968105;6600.9339906602245;6621.900671490028;6650.667466626746;4565.56627120423;4579.9542004579525;4589.908201835878;4594.448666160082;4603.884902877455;6793.354631310018;6800;6825.498390354114;6842.768301705741;6849.657517124024;6355.904661430175;6580.605163690194;6608.273089960197;6625.204975402982;6632.900506492503;6585.374389432996;6592.571482853599;6592.90110648331;6604.273529911609;6643.50173736962;6480.805575832733;6544.149260596282;6547.541672082908;6571.3757193066585;6575.967120164369;6523.18460192476;6615.636140012345;6629.370209830058;6632.635205063575;6636.668166591748;6380.872382552416;6399.648019358794;6406;6408.871822563616;6409.2949775525585 09:30:44 INFO - PID 3576 | |5;yui.html;813.365574851616;831.9292860106891;834.3617132893338;836.5942517878832;839.542449365096;14066.507672231473;14657.780133298009;15702.52892413228;16190.919045404771;16263.024218546896;17197.054162021082;18035.368762093298;18094.547636309067;18198.45404637863;18207;964.6237967192783;981.0826876870113;988.8318985772436;992.1467537917422;993.5727637116037;987.2299606307056;991.9504024798767;992.7319623701596;994.4530508220449;999.3154689038032;936.063936063936;1021.0861279155151;1021.6219998600528;1021.8007488539738;1022.8465730140501;1017.5550717980485;1021.0606242257142;1024.08856118055;1025.3232866308238;1031.4636389077712;749.0674110732174;750.474667732584;754.0273047768372;754.4153281207053;756.3722110648149;16312.592185195346;16328.510144695678;16337.509874703777;16387.180640967905;16525.421610243582;19039.524011899673;19105.80894191054;19574.412767616996;19618.31335903251;19620.607587848164;14873.925630371887;15195;15199;15206.923965380212;15236.619084522976;3355.5302257683943;3385.86456541738;3389.068006298263;3396.728261739055;3430.3482338355634;98536.50731746366;98769;99340;100257;100487.49756251245;14153.29233538319;14264.001519893716;14354.856451435351;14478.927605362116;14541.709165816625;27101.457970840867;27817;27865.30336741557;28047.859760701067;28115.57826632602;7690.884636730453;7972.202779721982;8085.029796424466;8234.752957411287;8239.588020598947;3790.6967442604528;3875.3605655067163;3882.2235552889533;3895.941560876589;3909.042284640281;4037.9798101009897;4085.8569950051606;4093.1404405074672;4111.362738775495;4116.259073366763;822.4160845799549;836.3899493475036;840.1934143222575;841.6128580852754;843.3127001493763;656.1371796088129;660.8645227728305;665.9200895892524;673.3838537738013;679.2562144451817;10553.155747540179;11741.4716337765;12210.572629958087;12839.293838838954;13086.345682715826;665.0556210181554;689.9068625735562;692.5429216716942;696.6690821859576;702.7224246422635;5001.44984051754;5213.635045546851;5452.345718513724;5489.615726899079;5954.642721436728;90906.54546727224;93068;94132.52933735287;94281.5285923566;95496;79525.60237198892;80498;80966.59516702378;81335.5933220342;81551;69139.30860691429;70058.2994170062;70944.16223351112;71949.64025179841;74322;10081.243906706879;10169.135623472088;10486.632967846088;10625.203109766644;10710.464476776286;28829.7117028827;30005.849970750005;30053;30833.845830770704;31355.843220784664;39518.40722389224;39799.80100099481;40265;40824.12170843765;41790.37314440225;17253.827461725723;17387.21757520889;17655.911720441316;17753.911230443766;17951.281948721906;18889.90555047216;19083;19451.70822437636;19523.21907123756;19650.803491964896;18216.271349145885;18267.269309227482;18316.900985940887;18453.72319415183;18839.717404238672;17432.738508922124;17444.12779361052;17479.12604369802;17481;17502.91248543749;17396.304147833944;17420.73868891993;17650.558736031187;17709.822901770818;17906.194221259815;10967.83548246761;11050.557977681125;11408.600698975495;11589.072874170215;11736.823947640964;11424.314541127558;12050.37319961794;12480.875191247971;12499.187552809039;12721.93639031799 09:30:44 INFO - PID 3576 | __end_tp_report 09:30:44 INFO - PID 3576 | __start_cc_report 09:30:44 INFO - PID 3576 | _x_x_mozilla_cycle_collect,379 09:30:44 INFO - PID 3576 | __end_cc_report 09:30:44 INFO - PID 3576 | __startTimestamp1496593844590__endTimestamp 09:30:44 INFO - PID 3576 | 09:30:44 INFO - PID 3576 | ------- Summary: start ------- 09:30:44 INFO - PID 3576 | Number of tests: 6 09:30:44 INFO - PID 3576 | 09:30:44 INFO - PID 3576 | [#0] dojo.html Cycles:165 Average:5898.56 Median:6098.39 stddev:665.07 (10.9%) stddev-sans-first:630.31 09:30:44 INFO - PID 3576 | Values: 3117.5 3130.8 3156.5 3168.0 3179.2 5823.2 5945.0 5956.4 5957.7 5974.4 5814.4 5879.6 5959.6 6003.3 6026.1 5326.6 5421.4 5442.6 5481.2 5554.7 5551.1 5566.3 5576.6 5578.2 5593.9 5400.9 5421.5 5462.9 5470.2 5509.7 5511.1 5531.2 5534.6 5548.6 5548.9 5434.7 5469.2 5474.7 5481.5 5484.1 5806.1 5917.7 5935.8 5943.0 5955.6 6252.1 6269.8 6375.5 6376.6 6396.7 6442.7 6490.0 6522.1 6529.3 6531.4 6019.5 6025.6 6030.5 6050.0 6057.3 6368.0 6447.1 6462.5 6546.5 6554.3 6099.1 6157.4 6164.2 6260.7 6302.6 6447.8 6462.2 6470.8 6480.2 6484.9 6429.2 6434.4 6439.6 6459.0 6464.7 6195.9 6238.5 6261.9 6366.4 6443.7 5211.5 5232.2 5234.0 5245.8 5280.8 4486.3 4488.3 4494.2 4514.3 4534.9 5474.5 5552.6 5597.4 5613.0 5632.8 6360.5 6376.7 6442.6 6453.9 6473.4 5575.4 5575.6 5609.5 5636.6 5658.2 5586.3 5702.3 5711.1 5719.1 5723.2 6039.9 6130.7 6136.1 6225.1 6240.5 6476.1 6503.5 6513.0 6524.9 6524.9 6258.2 6308.3 6312.7 6316.0 6342.8 6098.3 6179.2 6206.7 6327.9 6343.8 6420.5 6423.7 6453.1 6458.2 6464.5 6001.1 6098.4 6216.9 6254.5 6262.6 6101.7 6197.9 6226.8 6273.5 6277.7 6048.5 6124.9 6136.5 6188.5 6199.7 6143.2 6193.3 6212.1 6212.4 6289.8 6032.9 6033.2 6062.5 6098.4 6112.0 09:30:44 INFO - PID 3576 | 09:30:44 INFO - PID 3576 | [#1] ext.html Cycles:180 Average:35190.81 Median:34527.41 stddev:47906.63 (138.7%) stddev-sans-first:47971.03 09:30:44 INFO - PID 3576 | Values: 704.6 728.1 750.8 1154.3 1157.2 34791.0 35960.0 36008.6 36413.5 36547.8 38654.4 38823.2 38866.2 38971.2 39082.8 7237.9 7316.3 7430.4 7442.6 7487.1 7316.4 7387.7 7434.3 7464.4 7466.7 7447.0 7447.5 7472.5 7511.5 7522.9 7362.9 7440.0 7465.1 7468.6 7478.9 7297.7 7305.9 7323.6 7347.2 7349.2 36615.6 36890.6 36915.0 36933.8 37006.8 3526.0 3573.5 3575.5 3580.9 3583.0 28094.7 28117.9 28150.3 28304.3 28319.9 3556.7 3587.0 3591.9 3605.2 3613.3 141995.0 144336.0 157666.2 164186.0 164606.0 44065.6 44432.8 44473.3 44487.7 44492.6 45154.0 45244.3 51295.0 52342.5 52353.5 13645.9 13759.7 13836.4 13852.8 13886.6 10863.5 11019.2 11037.3 11075.7 11132.4 14311.6 14411.2 14532.4 14556.9 14674.6 5868.0 5918.6 5984.9 6017.2 6050.2 969.1 996.2 998.4 1004.3 1012.0 21405.5 22281.7 22450.6 22772.7 22866.9 1080.7 1088.4 1090.2 1093.0 1094.5 12066.9 12238.3 12379.4 14710.4 16455.2 202986.0 203214.0 203392.0 203863.0 204716.0 54333.2 54803.7 54829.7 54886.0 54971.7 1414.6 1455.1 1468.3 1469.4 1472.6 24640.6 25208.4 26705.5 26965.7 27180.3 47839.0 47845.0 48103.5 48295.8 48428.8 191913.0 191983.0 192700.0 192719.0 193183.0 33687.2 33991.6 34060.0 34196.7 34301.7 39496.0 40590.8 42031.4 42141.2 42174.4 29848.6 29992.3 30138.8 30197.0 31998.5 29430.4 29552.6 30025.8 30085.4 30961.0 33920.2 34498.8 34556.0 34613.0 34615.8 27156.7 28594.7 29345.4 29811.3 30198.0 23634.0 24520.4 24659.5 24749.3 24986.3 09:30:44 INFO - PID 3576 | 09:30:44 INFO - PID 3576 | [#2] jquery.html Cycles:180 Average:31751.74 Median:11170.04 stddev:79029.35 (707.5%) stddev-sans-first:79216.00 09:30:44 INFO - PID 3576 | Values: 405.0 415.8 416.5 425.4 437.6 14673.0 15387.8 20251.5 20931.6 20989.5 21052.3 22066.3 22107.2 22131.2 22139.2 5813.2 5989.9 6009.7 6035.1 6049.0 5888.2 5996.1 6010.3 6018.3 6032.9 5515.1 5782.9 5890.9 5958.6 5970.7 5736.2 5743.9 5783.7 5794.0 5798.4 5214.9 5221.2 5221.7 5235.9 5252.9 25294.7 25336.6 25382.2 25388.2 25444.1 1875.1 1931.9 1934.2 1936.7 1943.3 16023.2 16715.5 16777.9 16833.7 16899.4 2147.6 2204.7 2248.7 2250.1 2250.7 116341.0 117922.4 118088.4 118739.4 118819.0 10593.9 11292.4 11369.0 11455.2 11876.0 14981.6 14998.9 15018.1 15023.5 15072.5 8170.9 8204.3 8214.5 8236.2 8280.5 7902.2 7911.5 8004.1 8005.8 8040.6 7252.7 7272.3 7306.4 7393.3 7432.7 1932.3 1938.0 1950.2 1962.8 2088.6 942.6 959.8 972.6 989.7 993.5 17879.3 18477.5 18798.8 21528.9 23011.9 984.3 1012.0 1016.1 1031.3 1031.9 10124.1 10249.5 10466.5 10485.4 10583.3 466861.0 468314.0 473190.0 474327.0 474865.0 105225.5 105324.0 105712.5 107272.6 107647.0 1203.6 1209.4 1247.4 1248.9 1260.4 16064.6 19433.2 20965.4 21386.8 21394.7 51773.5 51868.0 52271.5 52310.2 53442.7 66696.7 67241.7 68115.0 68586.0 68719.0 15168.6 15584.2 15788.7 15789.1 15805.9 17736.7 17859.6 17884.2 18081.8 18097.9 14229.6 14869.3 15141.6 15197.4 15216.9 12855.9 13376.0 13431.9 13526.9 13602.6 14255.4 14366.7 14413.9 14466.5 14625.9 15027.2 15119.8 15130.6 15149.3 15166.9 14248.0 14865.9 14875.3 14933.4 15002.8 09:30:44 INFO - PID 3576 | 09:30:44 INFO - PID 3576 | [#3] mootools.html Cycles:180 Average:7171.51 Median:3925.96 stddev:4507.49 (114.8%) stddev-sans-first:4498.54 09:30:44 INFO - PID 3576 | Values: 1299.4 1360.4 1372.4 1375.1 1384.9 10827.6 11213.8 11357.4 11432.9 11722.2 11503.7 11707.0 11731.8 11744.6 11776.1 2422.6 2482.1 2488.9 2496.4 2499.0 2087.7 2166.3 2404.9 2416.4 2474.4 2446.5 2449.3 2475.4 2476.9 2478.6 2345.1 2345.8 2348.7 2354.7 2357.8 2321.1 2326.9 2334.5 2340.5 2346.5 11191.3 11384.9 11419.5 11433.8 11476.7 6326.9 6506.0 6518.9 6582.7 6588.9 3820.9 3910.2 3941.7 4031.1 4038.7 1240.3 1270.3 1303.0 1304.8 1304.8 16749.5 16928.7 16943.2 16945.9 16946.2 5104.9 5284.8 5292.9 5299.3 5387.5 12368.8 12417.3 12450.5 12456.8 12563.7 6252.2 6392.4 6442.5 6451.5 6455.1 5858.8 5977.3 5978.1 5979.6 6054.9 4213.7 4320.8 4366.2 4369.6 4390.8 1228.3 1267.4 1298.1 1300.2 1300.6 880.4 880.7 919.5 931.1 941.3 6923.9 7038.9 7222.7 7351.9 7625.0 925.2 979.5 979.8 993.2 995.8 4573.3 4790.2 4854.4 5010.5 5012.1 13823.0 14632.9 14659.7 14817.3 14861.5 14388.9 14554.4 14662.4 14726.0 14784.9 8920.3 8998.4 9077.0 9144.8 9174.8 6659.0 6984.5 7236.6 7285.9 7472.0 13240.3 13287.9 13316.8 13416.4 13617.1 13565.0 13580.6 13723.8 13765.8 13807.4 9508.3 9759.1 9796.0 9811.6 9826.9 9586.0 10721.9 10728.6 10866.5 10879.1 8717.3 9131.2 9283.4 9446.3 9476.3 9145.3 9150.7 9180.5 9291.7 9313.0 8170.1 8185.9 8255.5 8256.0 8269.0 6043.2 6138.7 6318.3 6348.7 6440.5 6319.5 6380.9 6497.5 6725.9 6758.2 09:30:44 INFO - PID 3576 | 09:30:44 INFO - PID 3576 | [#4] prototype.html Cycles:180 Average:5414.65 Median:6024.08 stddev:1621.67 (26.9%) stddev-sans-first:1581.54 09:30:44 INFO - PID 3576 | Values: 377.4 389.7 393.4 396.0 398.2 6036.0 6257.5 6278.5 6312.8 6346.4 5947.8 5973.5 6018.3 6065.8 6080.0 4747.0 4747.9 4748.9 4749.6 4775.5 4752.8 4762.9 4766.8 4773.3 4774.0 4707.5 4715.6 4717.7 4736.2 4741.5 4675.9 4725.2 4726.7 4734.7 4736.3 4124.9 4127.6 4129.4 4138.3 4149.9 5966.8 5979.1 6014.4 6029.9 6035.2 5432.2 5456.1 5457.9 5459.6 5472.3 6301.1 6329.0 6337.5 6340.2 6340.7 4505.2 4505.3 4514.7 4530.0 4531.5 6467.2 6579.8 6727.5 6835.0 6953.3 4542.5 4574.7 4579.7 4583.7 4593.5 4589.9 4591.2 4633.9 4644.0 4670.6 5243.4 5397.2 5403.3 5405.5 5410.7 6472.8 6524.4 6544.5 6568.1 6593.4 1601.4 1605.7 1608.8 1610.2 1612.2 1024.2 1070.5 1071.1 1083.8 1086.9 5846.6 5869.4 5870.2 5875.0 5901.6 6808.4 6810.0 6826.7 6830.0 6846.0 5777.4 5790.5 5800.0 5807.5 5826.4 3571.1 3584.8 3597.6 3604.9 3610.9 6576.8 6594.9 6595.5 6596.9 6603.0 6896.0 6919.9 6925.5 6929.5 6941.5 6523.0 6546.7 6555.3 6568.6 6577.9 6809.4 6832.4 6838.0 6846.5 6850.4 6680.6 6711.8 6719.0 6722.3 6724.2 6268.4 6526.3 6600.9 6621.9 6650.7 4565.6 4580.0 4589.9 4594.4 4603.9 6793.4 6800.0 6825.5 6842.8 6849.7 6355.9 6580.6 6608.3 6625.2 6632.9 6585.4 6592.6 6592.9 6604.3 6643.5 6480.8 6544.1 6547.5 6571.4 6576.0 6523.2 6615.6 6629.4 6632.6 6636.7 6380.9 6399.6 6406.0 6408.9 6409.3 09:30:44 INFO - PID 3576 | 09:30:44 INFO - PID 3576 | [#5] yui.html Cycles:180 Average:19757.29 Median:28472.64 stddev:25615.57 (90.0%) stddev-sans-first:25647.93 09:30:44 INFO - PID 3576 | Values: 813.4 831.9 834.4 836.6 839.5 14066.5 14657.8 15702.5 16190.9 16263.0 17197.1 18035.4 18094.5 18198.5 18207.0 964.6 981.1 988.8 992.1 993.6 987.2 992.0 992.7 994.5 999.3 936.1 1021.1 1021.6 1021.8 1022.8 1017.6 1021.1 1024.1 1025.3 1031.5 749.1 750.5 754.0 754.4 756.4 16312.6 16328.5 16337.5 16387.2 16525.4 19039.5 19105.8 19574.4 19618.3 19620.6 14873.9 15195.0 15199.0 15206.9 15236.6 3355.5 3385.9 3389.1 3396.7 3430.3 98536.5 98769.0 99340.0 100257.0 100487.5 14153.3 14264.0 14354.9 14478.9 14541.7 27101.5 27817.0 27865.3 28047.9 28115.6 7690.9 7972.2 8085.0 8234.8 8239.6 3790.7 3875.4 3882.2 3895.9 3909.0 4038.0 4085.9 4093.1 4111.4 4116.3 822.4 836.4 840.2 841.6 843.3 656.1 660.9 665.9 673.4 679.3 10553.2 11741.5 12210.6 12839.3 13086.3 665.1 689.9 692.5 696.7 702.7 5001.4 5213.6 5452.3 5489.6 5954.6 90906.5 93068.0 94132.5 94281.5 95496.0 79525.6 80498.0 80966.6 81335.6 81551.0 69139.3 70058.3 70944.2 71949.6 74322.0 10081.2 10169.1 10486.6 10625.2 10710.5 28829.7 30005.8 30053.0 30833.8 31355.8 39518.4 39799.8 40265.0 40824.1 41790.4 17253.8 17387.2 17655.9 17753.9 17951.3 18889.9 19083.0 19451.7 19523.2 19650.8 18216.3 18267.3 18316.9 18453.7 18839.7 17432.7 17444.1 17479.1 17481.0 17502.9 17396.3 17420.7 17650.6 17709.8 17906.2 10967.8 11050.6 11408.6 11589.1 11736.8 11424.3 12050.4 12480.9 12499.2 12721.9 09:30:44 INFO - PID 3576 | -------- Summary: end -------- 09:30:44 INFO - PID 3576 | 09:30:45 INFO - TEST-INFO | 3576: exit 0 09:30:45 INFO - TEST-OK | dromaeo_css | took 1144810ms 09:30:45 INFO - TEST-START | kraken 09:30:45 INFO - operating with platform_type : linux_ 09:30:45 INFO - Initialising browser for kraken test... 09:30:45 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48370/getInfo.html -profile /tmp/tmpqMdR_g/profile 09:30:45 INFO - TEST-INFO | started process 4001 (/builds/slave/test/build/application/firefox/firefox http://localhost:48370/getInfo.html) 09:31:20 INFO - TEST-INFO | 4001: killed by SIGTERM 09:31:20 INFO - Browser initialized. 09:31:20 INFO - Running cycle 1/1 for kraken test... 09:31:20 INFO - TEST-INFO | started process 4232 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqMdR_g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:31:32 INFO - PID 4232 | RSS: Main: 192311296 09:31:32 INFO - PID 4232 | 09:31:34 INFO - PID 4232 | Cycle 1(1): loaded http://localhost:48370/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48370/tests/kraken/driver.html?testName=audio-beat-detection) 09:31:35 INFO - PID 4232 | RSS: Main: 196022272 09:31:35 INFO - PID 4232 | 09:31:38 INFO - PID 4232 | Cycle 1(1): loaded http://localhost:48370/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48370/tests/kraken/driver.html?testName=audio-dft) 09:31:39 INFO - PID 4232 | RSS: Main: 195092480 09:31:39 INFO - PID 4232 | 09:31:41 INFO - PID 4232 | Cycle 1(1): loaded http://localhost:48370/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48370/tests/kraken/driver.html?testName=audio-fft) 09:31:42 INFO - PID 4232 | RSS: Main: 189837312 09:31:42 INFO - PID 4232 | 09:31:44 INFO - PID 4232 | Cycle 1(1): loaded http://localhost:48370/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48370/tests/kraken/driver.html?testName=audio-oscillator) 09:31:45 INFO - PID 4232 | RSS: Main: 190525440 09:31:45 INFO - PID 4232 | 09:31:47 INFO - PID 4232 | Cycle 1(1): loaded http://localhost:48370/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48370/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:31:48 INFO - PID 4232 | RSS: Main: 190631936 09:31:48 INFO - PID 4232 | 09:31:51 INFO - PID 4232 | Cycle 1(1): loaded http://localhost:48370/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48370/tests/kraken/driver.html?testName=imaging-darkroom) 09:31:51 INFO - PID 4232 | RSS: Main: 191533056 09:31:51 INFO - PID 4232 | 09:31:55 INFO - PID 4232 | Cycle 1(1): loaded http://localhost:48370/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48370/tests/kraken/driver.html?testName=imaging-desaturate) 09:31:55 INFO - PID 4232 | RSS: Main: 191385600 09:31:55 INFO - PID 4232 | 09:31:58 INFO - PID 4232 | Cycle 1(1): loaded http://localhost:48370/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48370/tests/kraken/driver.html?testName=json-parse-financial) 09:31:59 INFO - PID 4232 | RSS: Main: 191709184 09:31:59 INFO - PID 4232 | 09:32:01 INFO - PID 4232 | Cycle 1(1): loaded http://localhost:48370/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48370/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:32:01 INFO - PID 4232 | RSS: Main: 191713280 09:32:01 INFO - PID 4232 | 09:32:03 INFO - PID 4232 | Cycle 1(1): loaded http://localhost:48370/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48370/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:32:04 INFO - PID 4232 | RSS: Main: 191373312 09:32:04 INFO - PID 4232 | 09:32:06 INFO - PID 4232 | Cycle 1(1): loaded http://localhost:48370/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48370/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:32:07 INFO - PID 4232 | RSS: Main: 191676416 09:32:07 INFO - PID 4232 | 09:32:09 INFO - PID 4232 | Cycle 1(1): loaded http://localhost:48370/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48370/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:32:10 INFO - PID 4232 | RSS: Main: 191455232 09:32:10 INFO - PID 4232 | 09:32:13 INFO - PID 4232 | Cycle 1(1): loaded http://localhost:48370/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48370/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:32:14 INFO - PID 4232 | RSS: Main: 191238144 09:32:14 INFO - PID 4232 | 09:32:16 INFO - PID 4232 | Cycle 1(1): loaded http://localhost:48370/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48370/tests/kraken/driver.html?testName=ai-astar) 09:32:16 INFO - PID 4232 | RSS: Main: 192987136 09:32:16 INFO - PID 4232 | 09:32:16 INFO - PID 4232 | __start_tp_report 09:32:16 INFO - PID 4232 | _x_x_mozilla_page_load 09:32:16 INFO - PID 4232 | _x_x_mozilla_page_load_details 09:32:16 INFO - PID 4232 | |i|pagename|runs| 09:32:16 INFO - PID 4232 | |0;ai-astar;102;109;113;110;109;111;111;111;110;110 09:32:16 INFO - PID 4232 | |1;audio-beat-detection;146;126;126;169;121;123;122;123;145;122 09:32:16 INFO - PID 4232 | |2;audio-dft;163;164;162;163;161;165;170;180;165;163 09:32:16 INFO - PID 4232 | |3;audio-fft;72;76;75;115;74;77;74;75;96;76 09:32:16 INFO - PID 4232 | |4;audio-oscillator;84;84;99;83;82;82;112;81;84;109 09:32:16 INFO - PID 4232 | |5;imaging-gaussian-blur;114;115;113;115;114;114;114;114;114;115 09:32:16 INFO - PID 4232 | |6;imaging-darkroom;151;149;150;151;150;151;151;150;161;150 09:32:16 INFO - PID 4232 | |7;imaging-desaturate;95;94;94;94;94;94;95;95;94;94 09:32:16 INFO - PID 4232 | |8;json-parse-financial;56;55;53;55;67;54;56;55;54;58 09:32:16 INFO - PID 4232 | |9;json-stringify-tinderbox;55;55;56;55;55;56;55;54;55;55 09:32:16 INFO - PID 4232 | |10;stanford-crypto-aes;95;85;96;95;86;86;87;88;106;96 09:32:16 INFO - PID 4232 | |11;stanford-crypto-ccm;133;130;130;137;134;131;129;134;130;147 09:32:16 INFO - PID 4232 | |12;stanford-crypto-pbkdf2;188;194;202;197;198;198;200;200;200;196 09:32:16 INFO - PID 4232 | |13;stanford-crypto-sha256-iterative;73;72;71;69;71;69;72;72;70;69 09:32:16 INFO - PID 4232 | __end_tp_report 09:32:16 INFO - PID 4232 | __start_cc_report 09:32:16 INFO - PID 4232 | _x_x_mozilla_cycle_collect,988 09:32:16 INFO - PID 4232 | __end_cc_report 09:32:16 INFO - PID 4232 | __startTimestamp1496593936255__endTimestamp 09:32:16 INFO - PID 4232 | 09:32:16 INFO - PID 4232 | ------- Summary: start ------- 09:32:16 INFO - PID 4232 | Number of tests: 14 09:32:16 INFO - PID 4232 | 09:32:16 INFO - PID 4232 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.50 stddev:2.91 (2.6%) stddev-sans-first:1.24 09:32:16 INFO - PID 4232 | Values: 102.0 109.0 113.0 110.0 109.0 111.0 111.0 111.0 110.0 110.0 09:32:16 INFO - PID 4232 | 09:32:16 INFO - PID 4232 | [#1] audio-beat-detection Cycles:10 Average:132.30 Median:126.00 stddev:15.94 (12.7%) stddev-sans-first:16.12 09:32:16 INFO - PID 4232 | Values: 146.0 126.0 126.0 169.0 121.0 123.0 122.0 123.0 145.0 122.0 09:32:16 INFO - PID 4232 | 09:32:16 INFO - PID 4232 | [#2] audio-dft Cycles:10 Average:165.60 Median:164.50 stddev:5.62 (3.4%) stddev-sans-first:5.88 09:32:16 INFO - PID 4232 | Values: 163.0 164.0 162.0 163.0 161.0 165.0 170.0 180.0 165.0 163.0 09:32:16 INFO - PID 4232 | 09:32:16 INFO - PID 4232 | [#3] audio-fft Cycles:10 Average:81.00 Median:75.50 stddev:13.74 (18.2%) stddev-sans-first:14.18 09:32:16 INFO - PID 4232 | Values: 72.0 76.0 75.0 115.0 74.0 77.0 74.0 75.0 96.0 76.0 09:32:16 INFO - PID 4232 | 09:32:16 INFO - PID 4232 | [#4] audio-oscillator Cycles:10 Average:90.00 Median:83.50 stddev:11.98 (14.3%) stddev-sans-first:12.51 09:32:16 INFO - PID 4232 | Values: 84.0 84.0 99.0 83.0 82.0 82.0 112.0 81.0 84.0 109.0 09:32:16 INFO - PID 4232 | 09:32:16 INFO - PID 4232 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 09:32:16 INFO - PID 4232 | Values: 114.0 115.0 113.0 115.0 114.0 114.0 114.0 114.0 114.0 115.0 09:32:16 INFO - PID 4232 | 09:32:16 INFO - PID 4232 | [#6] imaging-darkroom Cycles:10 Average:151.40 Median:151.00 stddev:3.44 (2.3%) stddev-sans-first:3.64 09:32:16 INFO - PID 4232 | Values: 151.0 149.0 150.0 151.0 150.0 151.0 151.0 150.0 161.0 150.0 09:32:16 INFO - PID 4232 | 09:32:16 INFO - PID 4232 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 09:32:16 INFO - PID 4232 | Values: 95.0 94.0 94.0 94.0 94.0 94.0 95.0 95.0 94.0 94.0 09:32:16 INFO - PID 4232 | 09:32:16 INFO - PID 4232 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:55.50 stddev:4.00 (7.2%) stddev-sans-first:4.24 09:32:16 INFO - PID 4232 | Values: 56.0 55.0 53.0 55.0 67.0 54.0 56.0 55.0 54.0 58.0 09:32:16 INFO - PID 4232 | 09:32:16 INFO - PID 4232 | [#9] json-stringify-tinderbox Cycles:10 Average:55.10 Median:55.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 09:32:16 INFO - PID 4232 | Values: 55.0 55.0 56.0 55.0 55.0 56.0 55.0 54.0 55.0 55.0 09:32:16 INFO - PID 4232 | 09:32:16 INFO - PID 4232 | [#10] stanford-crypto-aes Cycles:10 Average:92.00 Median:91.50 stddev:6.73 (7.4%) stddev-sans-first:7.05 09:32:16 INFO - PID 4232 | Values: 95.0 85.0 96.0 95.0 86.0 86.0 87.0 88.0 106.0 96.0 09:32:16 INFO - PID 4232 | 09:32:16 INFO - PID 4232 | [#11] stanford-crypto-ccm Cycles:10 Average:133.50 Median:133.50 stddev:5.36 (4.0%) stddev-sans-first:5.68 09:32:16 INFO - PID 4232 | Values: 133.0 130.0 130.0 137.0 134.0 131.0 129.0 134.0 130.0 147.0 09:32:16 INFO - PID 4232 | 09:32:16 INFO - PID 4232 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.30 Median:199.00 stddev:4.00 (2.0%) stddev-sans-first:2.45 09:32:16 INFO - PID 4232 | Values: 188.0 194.0 202.0 197.0 198.0 198.0 200.0 200.0 200.0 196.0 09:32:16 INFO - PID 4232 | 09:32:16 INFO - PID 4232 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.50 stddev:1.48 (2.1%) stddev-sans-first:1.33 09:32:16 INFO - PID 4232 | Values: 73.0 72.0 71.0 69.0 71.0 69.0 72.0 72.0 70.0 69.0 09:32:16 INFO - PID 4232 | -------- Summary: end -------- 09:32:16 INFO - PID 4232 | 09:32:17 INFO - TEST-INFO | 4232: exit 0 09:32:17 INFO - TEST-OK | kraken | took 91969ms 09:32:17 INFO - SUITE-END | took 1236s 09:32:17 INFO - Completed test suite (00:20:36) 09:32:17 INFO - javascript benchmark 09:32:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7771.140275618895, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3117.485614873546, 3130.7808453408243, 3156.4949608062716, 3167.952480712789, 3179.205198700325, 5823.2138661280715, 5944.970275148624, 5956.404359564041, 5957.672328021968, 5974.372690867462, 5814.360420353758, 5879.559033072515, 5959.582829201958, 6003.339632640417, 6026.096085587164, 5326.627136100475, 5421.376541697716, 5442.6462279951875, 5481.177823326493, 5554.694491802949, 5551.1118221084635, 5566.304211973504, 5576.581756368289, 5578.191162281467, 5593.916091258634, 5400.91898621521, 5421.457854214586, 5462.945370546323, 5470.206820011116, 5509.696966666832, 5511.090670039439, 5531.197976293455, 5534.557235421156, 5548.5838562108, 5548.91676624851, 5434.673919564799, 5469.234307196995, 5474.7262636868, 5481.506664400184, 5484.149956756709, 5806.071028635398, 5917.674527900964, 5935.821925342247, 5943.0, 5955.642661440327, 6252.124702541648, 6269.811905642838, 6375.521835862282, 6376.585521941059, 6396.680165991682, 6442.742290308382, 6490.0, 6522.054302126166, 6529.281779004354, 6531.4448271896945, 6019.518438524908, 6025.638461692269, 6030.457258846681, 6050.0, 6057.303410107894, 6368.0, 6447.097406363113, 6462.547621666438, 6546.541742078104, 6554.3117972613145, 6099.11562823397, 6157.415045570753, 6164.229471316085, 6260.7495700171485, 6302.590331628429, 6447.838804029937, 6462.224533056064, 6470.805875823733, 6480.222373315232, 6484.935150648433, 6429.196350456193, 6434.388733070351, 6439.61362318253, 6458.967705161444, 6464.709088091047, 6195.876082478325, 6238.500919926395, 6261.9373806262265, 6366.395192456709, 6443.677816109176, 5211.504907033902, 5232.215167724872, 5234.0, 5245.763940622681, 5280.762365693553, 4486.2597671383855, 4488.326750987378, 4494.16857881293, 4514.34541991416, 4534.9319760203625, 5474.507294343528, 5552.639078459887, 5597.384287728347, 5612.989661860823, 5632.8028519002455, 6360.491160707133, 6376.744930202833, 6442.613443193423, 6453.903191452132, 6473.417392434703, 5575.414581468968, 5575.553955683536, 5609.523190528769, 5636.60543761941, 5658.207850900877, 5586.273784408001, 5702.344230413472, 5711.086226203787, 5719.113537401709, 5723.170140329712, 6039.909401358983, 6130.734471166763, 6136.079588061826, 6225.128482012431, 6240.500759939103, 6476.060971159061, 6503.544751867324, 6513.0, 6524.869502609827, 6524.934750652433, 6258.249010118815, 6308.27454842699, 6312.652804095819, 6315.96842015787, 6342.809715708536, 6098.250697042061, 6179.227596550431, 6206.689665516797, 6327.873442531031, 6343.841403964938, 6420.486361091195, 6423.7430502781235, 6453.064305675744, 6458.160439142881, 6464.5151613630105, 6001.129836173817, 6098.390160983866, 6216.906746398898, 6254.499640028877, 6262.5929314594405, 6101.731934812904, 6197.907031394623, 6226.813195604139, 6273.466755325666, 6277.654728989767, 6048.4858787003595, 6124.908126378019, 6136.549713441251, 6188.504919606511, 6199.659018754011, 6143.235544005126, 6193.349698281616, 6212.099245609452, 6212.390795865657, 6289.842753931189, 6032.8793424132145, 6033.215681961317, 6062.454379105901, 6098.420650038239, 6112.022076467744], "value": 5851.577866503887, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.5702121705758, 728.1262485017978, 750.8122969257686, 1154.3362566524252, 1157.230441756232, 34791.0, 35960.0, 36008.63991360089, 36413.45379819305, 36547.817260913725, 38654.420183697264, 38823.22353552927, 38866.22267554647, 38971.22057558847, 39082.8045859771, 7237.927620723778, 7316.341529262365, 7430.368418684418, 7442.590657513834, 7487.101547814243, 7316.414686825068, 7387.704491820321, 7434.330910218079, 7464.440166987498, 7466.738664146756, 7446.962765186194, 7447.4786764926475, 7472.514286571382, 7511.511751736147, 7522.887156692654, 7362.926370736332, 7439.962800185992, 7465.104187497481, 7468.551886886804, 7478.850422991537, 7297.708091676326, 7305.853882922365, 7323.597202153879, 7347.155077166088, 7349.191588925214, 36615.63384366149, 36890.631093688986, 36915.0, 36933.81533092344, 37006.814965925, 3525.964740352615, 3573.4818451324672, 3575.481555174485, 3580.856765729368, 3583.0, 28094.719052809414, 28117.85941070302, 28150.296242593893, 28304.292392690142, 28319.85840070807, 3556.697680697144, 3587.0, 3591.910202244939, 3605.1708107135505, 3613.331533666254, 141995.0, 144336.0, 157666.21166894207, 164186.0, 164606.0, 44065.559344406785, 44432.77783611061, 44473.33290000653, 44487.6653700383, 44492.55507444884, 45154.0, 45244.32133518, 51295.0, 52342.47657523452, 52353.47646523486, 13645.931770341085, 13759.724805504035, 13836.377363018688, 13852.792208116887, 13886.583402497941, 10863.51114199863, 11019.228653994303, 11037.337759734442, 11075.667729968114, 11132.443377831076, 14311.642208944651, 14411.207383593794, 14532.418703251751, 14556.927215363856, 14674.55976320712, 5867.970660146757, 5918.556108291896, 5984.940150598525, 6017.247844019497, 6050.183225264533, 969.1132613658565, 996.1881066930429, 998.4358837256926, 1004.322082594246, 1011.9898801012043, 21405.464863378227, 22281.66577501339, 22450.550988980456, 22772.65841012353, 22866.885665571564, 1080.6757972608186, 1088.3687461272443, 1090.2422816142705, 1092.9781404371868, 1094.496531595475, 12066.939665301792, 12238.265704057607, 12379.381030948416, 14710.41158353654, 16455.177241138135, 202986.0, 203214.0, 203392.0, 203863.0, 204716.0, 54333.185002225, 54803.72598136984, 54829.72585137129, 54886.0, 54971.72514137404, 1414.5968399006233, 1455.1123814473162, 1468.3098943496539, 1469.3681716861852, 1472.5729538433948, 24640.644764538123, 25208.36979075538, 26705.465890682466, 26965.73034269711, 27180.32049198786, 47839.0, 47845.0, 48103.518964809904, 48295.75852120717, 48428.7578562119, 191913.0, 191983.0, 192700.0, 192719.0, 193183.0, 33687.15782105467, 33991.64033438635, 34060.0, 34196.65803342034, 34301.712285964255, 39496.0, 40590.79704601458, 42031.3695294577, 42141.157176855675, 42174.36738448864, 29848.552271716377, 29992.250193744458, 30138.84930575333, 30197.0, 31998.52002219922, 29430.41139177247, 29552.55671164891, 30025.849870750506, 30085.3982920336, 30961.0, 33920.15199620029, 34498.82750586231, 34556.0, 34613.0, 34615.826920865235, 27156.72843271542, 28594.714052860036, 29345.413091738472, 29811.254718632208, 30198.0, 23634.0, 24520.386990325384, 24659.506809863342, 24749.25752227436, 24986.250412487654], "value": 16502.484361422175, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.98177582008805, 415.79002603685143, 416.53764321602995, 425.4447945431212, 437.5952244174138, 14672.999999999973, 15387.846121538782, 20251.49371265717, 20931.581368372623, 20989.47526311843, 21052.263170789025, 22066.33800985969, 22107.226247081355, 22131.225407110753, 22139.225127120553, 5813.244278243833, 5989.88020239595, 6009.699515024253, 6035.124906888521, 6049.032154855224, 5888.205092312526, 5996.100584912255, 6010.27876654802, 6018.307894592134, 6032.879342413171, 5515.09001014832, 5782.913256301159, 5890.911636325459, 5958.553108516857, 5970.731317090741, 5736.225609542721, 5743.885122297552, 5783.6529808211435, 5794.0, 5798.3911689272445, 5214.921776173361, 5221.190715439113, 5221.71280579568, 5235.869103272411, 5252.947470525322, 25294.74705252961, 25336.619950700755, 25382.238532844043, 25388.238352849443, 25444.109456168946, 1875.1093230715437, 1931.874428162165, 1934.1586409911592, 1936.738540297056, 1943.2712732725229, 16023.198840058067, 16715.498535043967, 16777.916110419494, 16833.66332673352, 16899.408520701716, 2147.6134295826746, 2204.680321353411, 2248.6964259824877, 2250.1224522436264, 2250.718660167479, 116341.0, 117922.41038794837, 118088.40955795338, 118739.4063029688, 118819.0, 10593.89406105929, 11292.378919159524, 11369.0, 11455.198136130392, 11876.0, 14981.625459363386, 14998.925005374904, 15018.098914065191, 15023.474178403703, 15072.472463463726, 8170.877436838452, 8204.343652507785, 8214.4660597061, 8236.217559331853, 8280.544570048585, 7902.209779022051, 7911.496815605132, 8004.119546849958, 8005.799855003672, 8040.5979701015885, 7252.746153884589, 7272.345488906024, 7306.415486761046, 7393.297636724503, 7432.702691892372, 1932.304435312731, 1937.9612407752047, 1950.2199120351972, 1962.833159181457, 2088.5927244187237, 942.6229508196776, 959.8314442341762, 972.5769290358717, 989.6585677941099, 993.5181437003048, 17879.28482860697, 18477.53806154857, 18798.812011879978, 21528.892355538123, 23011.88494057519, 984.2962281968427, 1011.9696409107738, 1016.11090295991, 1031.3141760729181, 1031.8555402243542, 10124.139448146843, 10249.538770755335, 10466.488042869656, 10485.37087774736, 10583.25917185805, 466861.0, 468314.0, 473190.0, 474327.0, 474865.0, 105225.47387263014, 105324.0, 105712.47143764232, 107272.63636818128, 107647.0, 1203.6328919679581, 1209.3953023488257, 1247.3887794980576, 1248.9437975291316, 1260.4013093780563, 16064.598385040468, 19433.222671093565, 20965.37103886886, 21386.78613213848, 21394.679079813504, 51773.48226517686, 51868.0, 52271.47728522818, 52310.215346769066, 53442.73278633582, 66696.6665166671, 67241.66379168072, 68115.0, 68586.0, 68719.0, 15168.620784480476, 15584.22078896028, 15788.68422631564, 15789.131597762233, 15805.920970395535, 17736.733948990517, 17859.642807144046, 17884.195211215785, 18081.819181808012, 18097.909510452362, 14229.573112806633, 14869.330880110638, 15141.621459463602, 15197.392104315704, 15216.869638250433, 12855.87144128584, 13376.0, 13431.932840335736, 13526.864731352955, 13602.591922242349, 14255.358508867334, 14366.712665746836, 14413.927930360282, 14466.493672721404, 14625.85374146245, 15027.219964306638, 15119.848801511844, 15130.621734456727, 15149.318280677617, 15166.924165379103, 14248.0, 14865.878165585349, 14875.256237188314, 14933.402663893323, 15002.774958375414], "value": 10506.10598748392, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1299.3568183749046, 1360.3606305036635, 1372.4235820955198, 1375.113052081407, 1384.9446022159113, 10827.566897324108, 11213.775724485515, 11357.375344356056, 11432.885671143285, 11722.23805452645, 11503.654890353282, 11707.0, 11731.765364692701, 11744.588939387124, 11776.116791240669, 2422.6002709552945, 2482.1064416809936, 2488.8631125288102, 2496.4383013821925, 2498.9875050624723, 2087.6972838938345, 2166.306781829815, 2404.9398765030837, 2416.4079800448912, 2474.393773525489, 2446.522928029026, 2449.326435230308, 2475.356407334088, 2476.863772492512, 2478.566250906093, 2345.1323010486144, 2345.8240631952585, 2348.694669692929, 2354.682117914077, 2357.823163262762, 2321.071571371448, 2326.895289711967, 2334.498082912182, 2340.508493216427, 2346.5306938612175, 11191.32852028881, 11384.886151138548, 11419.54321827126, 11433.771324573461, 11476.71308217293, 6326.87346253077, 6505.967470162666, 6518.93481065188, 6582.736690532373, 6588.868222635569, 3820.9235815283537, 3910.1788624388914, 3941.743786653887, 4031.093004074089, 4038.697097717683, 1240.3302216802915, 1270.3076823131416, 1302.9934850325783, 1304.778187708092, 1304.8173255744202, 16749.497515074567, 16928.66142677152, 16943.237554310086, 16945.915270423568, 16946.152692365456, 5104.923426148611, 5284.815031473957, 5292.92060619091, 5299.329717202633, 5387.488188622075, 12368.81446778299, 12417.31704756229, 12450.501979920882, 12456.75086498283, 12563.748725025449, 6252.187215661935, 6392.3927226913365, 6442.48460123189, 6451.451626611791, 6455.128557644658, 5858.794942177088, 5977.252843394575, 5978.133170690226, 5979.611325263844, 6054.939450605438, 4213.747175169499, 4320.783960801948, 4366.170427618742, 4369.584889435499, 4390.780460976938, 1228.2753175626424, 1267.353649638691, 1298.0783643612951, 1300.1548993154524, 1300.6293206436121, 880.3969281042379, 880.7137680253943, 919.5172534419484, 931.1293940165966, 941.3363578677016, 6923.861522769617, 7038.894416583756, 7222.711091556384, 7351.926480735231, 7624.961875190588, 925.153484561632, 979.5200351827554, 979.8089372572423, 993.1955116355775, 995.8008398320364, 4573.291139873325, 4790.161721698759, 4854.368932038883, 5010.498950105033, 5012.147934851084, 13823.0, 14632.926835365968, 14659.706805863823, 14817.333220005126, 14861.479848205478, 14388.856111438961, 14554.41782328695, 14662.413503459742, 14726.0, 14784.852151478563, 8920.330975176888, 8998.370114091951, 9077.0, 9144.817103658022, 9174.770630734152, 6659.044887756545, 6984.511084224056, 7236.565806051653, 7285.927140728525, 7472.0, 13240.271785051915, 13287.867121329049, 13316.800247996482, 13416.39626216842, 13617.140400516002, 13565.0, 13580.592582222549, 13723.794143088062, 13765.793513097511, 13807.378667959765, 9508.28687848428, 9759.072888075621, 9796.0, 9811.558479868565, 9826.901730982885, 9585.952070239604, 10721.892781072402, 10728.624498142528, 10866.511007004545, 10879.129669626569, 8717.346199035224, 9131.223845972901, 9283.35016548862, 9446.29152813528, 9476.336656433983, 9145.268378529569, 9150.725478235663, 9180.540972951192, 9291.72124836256, 9312.953435232781, 8170.142135075732, 8185.918140818516, 8255.545944973084, 8256.0, 8268.958655206685, 6043.214382130295, 6138.723757430837, 6318.273398559225, 6348.714307856065, 6440.516961227833, 6319.526035547445, 6380.9361906380345, 6497.545171837926, 6725.865482690417, 6758.222804377559], "value": 5429.804504440544, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.44138674761354, 389.73498021345483, 393.40595700492247, 396.0356531844956, 398.2473125792253, 6035.9698201509045, 6257.468115210213, 6278.529110316727, 6312.769010043044, 6346.4288214060725, 5947.791827286046, 5973.506623344164, 6018.277806663195, 6065.757369705218, 6080.0, 4746.976265118669, 4747.881302967419, 4748.8575342739605, 4749.572538471537, 4775.474697783241, 4752.7861246244, 4762.857114286577, 4766.833160839371, 4773.260144677581, 4774.0, 4707.45864225615, 4715.575598196162, 4717.69334993226, 4736.171170045245, 4741.478437371887, 4675.88310292242, 4725.243960966263, 4726.692764970266, 4734.715917044971, 4736.289556566542, 4124.938125928114, 4127.607877251657, 4129.421880936671, 4138.337865941465, 4149.854755083557, 5966.820995370146, 5979.146464595946, 6014.3985601439945, 6029.879402411971, 6035.155078289043, 5432.2123292122815, 5456.127019676833, 5457.918131228034, 5459.617826752129, 5472.315960504937, 6301.14934483848, 6328.968355158241, 6337.461315788163, 6340.207474065742, 6340.682965851689, 4505.189065968125, 4505.324201369788, 4514.706544074657, 4529.954700452986, 4531.546845315475, 6467.191601049869, 6579.848526507842, 6727.461803055793, 6834.9658251708925, 6953.341261354904, 4542.500324964251, 4574.656900732459, 4579.656525760514, 4583.702059366131, 4593.517680643551, 4589.852536865784, 4591.242444996605, 4633.911030907734, 4643.95356046442, 4670.626349892001, 5243.449437809051, 5397.190421436738, 5403.270558474555, 5405.459454054641, 5410.675359478365, 6472.773452929125, 6524.380183882524, 6544.54188206821, 6568.146141001639, 6593.439557637655, 1601.3674598533514, 1605.6868910562328, 1608.766728824314, 1610.15466879889, 1612.2261314569073, 1024.2267088348249, 1070.4594179939236, 1071.1056268016293, 1083.7832433513172, 1086.8805130715375, 5846.561507886926, 5869.413058694096, 5870.236869206976, 5875.030619947746, 5901.557383196277, 6808.353206445379, 6809.965950170217, 6826.658667066627, 6829.965850170717, 6846.007328937276, 5777.422257774273, 5790.478856902899, 5799.971000144972, 5807.5063619591965, 5826.446487583673, 3571.142925697814, 3584.8386822593047, 3597.568291805, 3604.9098772530897, 3610.8736194233074, 6576.769813056616, 6594.934050659432, 6595.505337099737, 6596.868062638816, 6603.042558828943, 6896.0, 6919.930800691928, 6925.480588955848, 6929.480288978347, 6941.548799328028, 6523.0, 6546.672666366758, 6555.344465553407, 6568.605883647092, 6577.934220657828, 6809.38715515606, 6832.369537727911, 6838.04267402574, 6846.452283817183, 6850.417714494324, 6680.6283769263155, 6711.832204194934, 6718.966405167943, 6722.327767223239, 6724.226713927961, 6268.373162683877, 6526.282108968105, 6600.9339906602245, 6621.900671490028, 6650.667466626746, 4565.56627120423, 4579.9542004579525, 4589.908201835878, 4594.448666160082, 4603.884902877455, 6793.354631310018, 6800.0, 6825.498390354114, 6842.768301705741, 6849.657517124024, 6355.904661430175, 6580.605163690194, 6608.273089960197, 6625.204975402982, 6632.900506492503, 6585.374389432996, 6592.571482853599, 6592.90110648331, 6604.273529911609, 6643.50173736962, 6480.805575832733, 6544.149260596282, 6547.541672082908, 6571.3757193066585, 6575.967120164369, 6523.18460192476, 6615.636140012345, 6629.370209830058, 6632.635205063575, 6636.668166591748, 6380.872382552416, 6399.648019358794, 6406.0, 6408.871822563616, 6409.2949775525585], "value": 4898.160851620917, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [813.365574851616, 831.9292860106891, 834.3617132893338, 836.5942517878832, 839.542449365096, 14066.507672231473, 14657.780133298009, 15702.52892413228, 16190.919045404771, 16263.024218546896, 17197.054162021082, 18035.368762093298, 18094.547636309067, 18198.45404637863, 18207.0, 964.6237967192783, 981.0826876870113, 988.8318985772436, 992.1467537917422, 993.5727637116037, 987.2299606307056, 991.9504024798767, 992.7319623701596, 994.4530508220449, 999.3154689038032, 936.063936063936, 1021.0861279155151, 1021.6219998600528, 1021.8007488539738, 1022.8465730140501, 1017.5550717980485, 1021.0606242257142, 1024.08856118055, 1025.3232866308238, 1031.4636389077712, 749.0674110732174, 750.474667732584, 754.0273047768372, 754.4153281207053, 756.3722110648149, 16312.592185195346, 16328.510144695678, 16337.509874703777, 16387.180640967905, 16525.421610243582, 19039.524011899673, 19105.80894191054, 19574.412767616996, 19618.31335903251, 19620.607587848164, 14873.925630371887, 15195.0, 15199.0, 15206.923965380212, 15236.619084522976, 3355.5302257683943, 3385.86456541738, 3389.068006298263, 3396.728261739055, 3430.3482338355634, 98536.50731746366, 98769.0, 99340.0, 100257.0, 100487.49756251245, 14153.29233538319, 14264.001519893716, 14354.856451435351, 14478.927605362116, 14541.709165816625, 27101.457970840867, 27817.0, 27865.30336741557, 28047.859760701067, 28115.57826632602, 7690.884636730453, 7972.202779721982, 8085.029796424466, 8234.752957411287, 8239.588020598947, 3790.6967442604528, 3875.3605655067163, 3882.2235552889533, 3895.941560876589, 3909.042284640281, 4037.9798101009897, 4085.8569950051606, 4093.1404405074672, 4111.362738775495, 4116.259073366763, 822.4160845799549, 836.3899493475036, 840.1934143222575, 841.6128580852754, 843.3127001493763, 656.1371796088129, 660.8645227728305, 665.9200895892524, 673.3838537738013, 679.2562144451817, 10553.155747540179, 11741.4716337765, 12210.572629958087, 12839.293838838954, 13086.345682715826, 665.0556210181554, 689.9068625735562, 692.5429216716942, 696.6690821859576, 702.7224246422635, 5001.44984051754, 5213.635045546851, 5452.345718513724, 5489.615726899079, 5954.642721436728, 90906.54546727224, 93068.0, 94132.52933735287, 94281.5285923566, 95496.0, 79525.60237198892, 80498.0, 80966.59516702378, 81335.5933220342, 81551.0, 69139.30860691429, 70058.2994170062, 70944.16223351112, 71949.64025179841, 74322.0, 10081.243906706879, 10169.135623472088, 10486.632967846088, 10625.203109766644, 10710.464476776286, 28829.7117028827, 30005.849970750005, 30053.0, 30833.845830770704, 31355.843220784664, 39518.40722389224, 39799.80100099481, 40265.0, 40824.12170843765, 41790.37314440225, 17253.827461725723, 17387.21757520889, 17655.911720441316, 17753.911230443766, 17951.281948721906, 18889.90555047216, 19083.0, 19451.70822437636, 19523.21907123756, 19650.803491964896, 18216.271349145885, 18267.269309227482, 18316.900985940887, 18453.72319415183, 18839.717404238672, 17432.738508922124, 17444.12779361052, 17479.12604369802, 17481.0, 17502.91248543749, 17396.304147833944, 17420.73868891993, 17650.558736031187, 17709.822901770818, 17906.194221259815, 10967.83548246761, 11050.557977681125, 11408.600698975495, 11589.072874170215, 11736.823947640964, 11424.314541127558, 12050.37319961794, 12480.875191247971, 12499.187552809039, 12721.93639031799], "value": 8162.040559860265, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 109.0, 113.0, 110.0, 109.0, 111.0, 111.0, 111.0, 110.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 126.0, 126.0, 169.0, 121.0, 123.0, 122.0, 123.0, 145.0, 122.0], "value": 132.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 162.0, 163.0, 161.0, 165.0, 170.0, 180.0, 165.0, 163.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 76.0, 75.0, 115.0, 74.0, 77.0, 74.0, 75.0, 96.0, 76.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 99.0, 83.0, 82.0, 82.0, 112.0, 81.0, 84.0, 109.0], "value": 90.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 113.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 150.0, 151.0, 150.0, 151.0, 151.0, 150.0, 161.0, 150.0], "value": 151.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 53.0, 55.0, 67.0, 54.0, 56.0, 55.0, 54.0, 58.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 55.0, 55.0, 56.0, 55.0, 54.0, 55.0, 55.0], "value": 55.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 85.0, 96.0, 95.0, 86.0, 86.0, 87.0, 88.0, 106.0, 96.0], "value": 92.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 130.0, 130.0, 137.0, 134.0, 131.0, 129.0, 134.0, 130.0, 147.0], "value": 133.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 194.0, 202.0, 197.0, 198.0, 198.0, 200.0, 200.0, 200.0, 196.0], "value": 197.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 71.0, 69.0, 71.0, 69.0, 72.0, 72.0, 70.0, 69.0], "value": 70.8, "unit": "score"}]}]} 09:32:17 INFO - Return code: 0 09:32:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:32:17 INFO - # TBPL SUCCESS # 09:32:17 INFO - Running post-action listener: _resource_record_post_action 09:32:17 INFO - [mozharness: 2017-06-04 16:32:17.620165Z] Finished run-tests step (success) 09:32:17 INFO - Running post-run listener: _resource_record_post_run 09:32:17 INFO - Total resource usage - Wall time: 1254s; CPU: 13.0%; Read bytes: 8572928; Write bytes: 442961920; Read time: 1404; Write time: 290872 09:32:17 INFO - TinderboxPrint: CPU usage
12.7% 09:32:17 INFO - TinderboxPrint: I/O read bytes / time
8,572,928 / 1,404 09:32:17 INFO - TinderboxPrint: I/O write bytes / time
442,961,920 / 290,872 09:32:17 INFO - TinderboxPrint: CPU idle
8,737.8 (87.3%) 09:32:17 INFO - TinderboxPrint: CPU user
1,213.8 (12.1%) 09:32:17 INFO - TinderboxPrint: Swap in / out
0 / 0 09:32:17 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 113946624; Read time: 0; Write time: 81396 09:32:17 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:32:17 INFO - run-tests - Wall time: 1237s; CPU: 13.0%; Read bytes: 6541312; Write bytes: 329015296; Read time: 1336; Write time: 209476 09:32:18 INFO - Running post-run listener: _upload_blobber_files 09:32:18 INFO - Blob upload gear active. 09:32:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:32:18 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 09:32:18 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'] 09:32:18 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 09:32:18 INFO - (blobuploader) - INFO - Open directory for files ... 09:32:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:32:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:32:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:32:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:32:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:32:19 INFO - (blobuploader) - INFO - Done attempting. 09:32:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:32:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:32:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:32:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:32:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:32:22 INFO - (blobuploader) - INFO - Done attempting. 09:32:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:32:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:32:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:32:23 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:32:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:32:23 INFO - (blobuploader) - INFO - Done attempting. 09:32:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:32:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:32:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:32:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:32:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:32:24 INFO - (blobuploader) - INFO - Done attempting. 09:32:24 INFO - (blobuploader) - INFO - Iteration through files over. 09:32:24 INFO - Return code: 0 09:32:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:32:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:32:24 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/acc357058b0843273cd9eb1d56c9db64d027b53e60e71256422afd109d75c1d0eda242d1cf28a496f39e79c7f4fec3f924259df5274892df71a1cb8e650ade6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3353e8bc425876696d73e889329b528bf9e2214be6baaf4caae84e2750127428362476d0249a3c921386e797757910fdb01bd880c59b1ace3edd68d9a29c765", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8d74191ac93f506f916cc22175a575d582ae5136f2a099ee896412b0a9a591c481d6a3aacbc47e7a2ae4c23e523c8c3bd3d62ef2abb617f7953784eb51ac928", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b0af9cae84ac9957f34a984b42c7b49a47533efd9b8835e79d82f023c16a6fed18659220d92e648c5e1617c50cc961f1cb921dceea89b44f9d9fe142deef939"} 09:32:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:32:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:32:24 INFO - Contents: 09:32:24 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/acc357058b0843273cd9eb1d56c9db64d027b53e60e71256422afd109d75c1d0eda242d1cf28a496f39e79c7f4fec3f924259df5274892df71a1cb8e650ade6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3353e8bc425876696d73e889329b528bf9e2214be6baaf4caae84e2750127428362476d0249a3c921386e797757910fdb01bd880c59b1ace3edd68d9a29c765", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8d74191ac93f506f916cc22175a575d582ae5136f2a099ee896412b0a9a591c481d6a3aacbc47e7a2ae4c23e523c8c3bd3d62ef2abb617f7953784eb51ac928", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b0af9cae84ac9957f34a984b42c7b49a47533efd9b8835e79d82f023c16a6fed18659220d92e648c5e1617c50cc961f1cb921dceea89b44f9d9fe142deef939"} 09:32:24 INFO - Running post-run listener: copy_logs_to_upload_dir 09:32:24 INFO - Copying logs to upload dir... 09:32:24 INFO - mkdir: /builds/slave/test/build/upload/logs 09:32:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1316.154221 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2017-06-04 09:32:24.696682) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-04 09:32:24.700302) ========= 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=9f7544b6a75ada7b6b576032000001a7-1496587294.882209-355335228 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/acc357058b0843273cd9eb1d56c9db64d027b53e60e71256422afd109d75c1d0eda242d1cf28a496f39e79c7f4fec3f924259df5274892df71a1cb8e650ade6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3353e8bc425876696d73e889329b528bf9e2214be6baaf4caae84e2750127428362476d0249a3c921386e797757910fdb01bd880c59b1ace3edd68d9a29c765", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8d74191ac93f506f916cc22175a575d582ae5136f2a099ee896412b0a9a591c481d6a3aacbc47e7a2ae4c23e523c8c3bd3d62ef2abb617f7953784eb51ac928", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b0af9cae84ac9957f34a984b42c7b49a47533efd9b8835e79d82f023c16a6fed18659220d92e648c5e1617c50cc961f1cb921dceea89b44f9d9fe142deef939"} build_url:https://queue.taskcluster.net/v1/task/furA-O8fRNWCXibHPkuJPA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011192 build_url: 'https://queue.taskcluster.net/v1/task/furA-O8fRNWCXibHPkuJPA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/acc357058b0843273cd9eb1d56c9db64d027b53e60e71256422afd109d75c1d0eda242d1cf28a496f39e79c7f4fec3f924259df5274892df71a1cb8e650ade6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3353e8bc425876696d73e889329b528bf9e2214be6baaf4caae84e2750127428362476d0249a3c921386e797757910fdb01bd880c59b1ace3edd68d9a29c765", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8d74191ac93f506f916cc22175a575d582ae5136f2a099ee896412b0a9a591c481d6a3aacbc47e7a2ae4c23e523c8c3bd3d62ef2abb617f7953784eb51ac928", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b0af9cae84ac9957f34a984b42c7b49a47533efd9b8835e79d82f023c16a6fed18659220d92e648c5e1617c50cc961f1cb921dceea89b44f9d9fe142deef939"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-04 09:32:24.724608) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-04 09:32:24.724948) ========= 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=9f7544b6a75ada7b6b576032000001a7-1496587294.882209-355335228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004409 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-04 09:32:24.809880) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-04 09:32:24.810198) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-04 09:32:24.810525) ========= ========= Total master_lag: 0.19 =========