builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-002 starttime: 1497457147.22 results: success (0) revision: da66c4a05fda49d457d9411a7092fed87cf9e53a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-14 09:19:07.220859) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-14 09:19:07.221241) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-14 09:19:07.221504) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-14 09:19:07.241142) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-14 09:19:07.241392) ========= 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=a0d2d2de893abaa8702a9954000001a7-1497448790.253951-1184151064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-14 09:19:07-- 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% 67.0M=0s 2017-06-14 09:19:07 (67.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122006 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-14 09:19:07.373623) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-14 09:19:07.373895) ========= 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=a0d2d2de893abaa8702a9954000001a7-1497448790.253951-1184151064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017249 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-14 09:19:07.458949) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-14 09:19:07.459443) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev da66c4a05fda49d457d9411a7092fed87cf9e53a --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 da66c4a05fda49d457d9411a7092fed87cf9e53a --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=a0d2d2de893abaa8702a9954000001a7-1497448790.253951-1184151064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-14 09:19:07,558 truncating revision to first 12 chars 2017-06-14 09:19:07,558 Setting DEBUG logging. 2017-06-14 09:19:07,558 attempt 1/10 2017-06-14 09:19:07,558 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/da66c4a05fda?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-14 09:19:08,244 unpacking tar archive at: mozilla-central-da66c4a05fda/testing/mozharness/ program finished with exit code 0 elapsedTime=1.002918 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-14 09:19:08.487783) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-14 09:19:08.488090) ========= script_repo_revision: da66c4a05fda49d457d9411a7092fed87cf9e53a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-14 09:19:08.488442) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-14 09:19:08.488696) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-14 09:19:08.498216) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2017-06-14 09:19:08.498476) ========= /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=a0d2d2de893abaa8702a9954000001a7-1497448790.253951-1184151064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:19:08 INFO - MultiFileLogger online at 20170614 09:19:08 in /builds/slave/test 09:19:08 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:19:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:19:08 INFO - {'append_to_log': False, 09:19:08 INFO - 'base_work_dir': '/builds/slave/test', 09:19:08 INFO - 'blob_upload_branch': 'Firefox', 09:19:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:19:08 INFO - 'branch': 'Firefox', 09:19:08 INFO - 'buildbot_json_path': 'buildprops.json', 09:19:08 INFO - 'config_files': ('talos/linux_config.py',), 09:19:08 INFO - 'default_actions': ('clobber', 09:19:08 INFO - 'read-buildbot-config', 09:19:08 INFO - 'download-and-extract', 09:19:08 INFO - 'populate-webroot', 09:19:08 INFO - 'create-virtualenv', 09:19:08 INFO - 'install', 09:19:08 INFO - 'setup-mitmproxy', 09:19:08 INFO - 'run-tests'), 09:19:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:19:08 INFO - 'download_minidump_stackwalk': True, 09:19:08 INFO - 'download_symbols': 'ondemand', 09:19:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:19:08 INFO - 'tooltool.py': '/tools/tooltool.py', 09:19:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:19:08 INFO - '/tools/misc-python/virtualenv.py')}, 09:19:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:19:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:19:08 INFO - 'gecko_profile': False, 09:19:08 INFO - 'gecko_profile_interval': 0, 09:19:08 INFO - 'installer_path': 'installer.exe', 09:19:08 INFO - 'log_level': 'info', 09:19:08 INFO - 'log_name': 'talos', 09:19:08 INFO - 'log_to_console': True, 09:19:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:19:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:19:08 INFO - 'opt_config_files': (), 09:19:08 INFO - 'pip_index': False, 09:19:08 INFO - 'suite': 'dromaeojs-e10s', 09:19:08 INFO - 'system_bits': '32', 09:19:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:19:08 INFO - 'title': 'talos-linux64-ix-002', 09:19:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:19:08 INFO - 'use_talos_json': True, 09:19:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:19:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:19:08 INFO - 'work_dir': 'build'} 09:19:08 INFO - [mozharness: 2017-06-14 16:19:08.693016Z] Running clobber step. 09:19:08 INFO - Running pre-action listener: _resource_record_pre_action 09:19:08 INFO - Running main action method: clobber 09:19:08 INFO - rmtree: /builds/slave/test/build 09:19:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:19:09 INFO - Running post-action listener: _resource_record_post_action 09:19:09 INFO - [mozharness: 2017-06-14 16:19:09.702445Z] Finished clobber step (success) 09:19:09 INFO - [mozharness: 2017-06-14 16:19:09.702545Z] Running read-buildbot-config step. 09:19:09 INFO - Running pre-action listener: _resource_record_pre_action 09:19:09 INFO - Running main action method: read_buildbot_config 09:19:09 INFO - Using buildbot properties: 09:19:09 INFO - { 09:19:09 INFO - "project": "", 09:19:09 INFO - "product": "firefox", 09:19:09 INFO - "who": "ffxbld@noreply.mozilla.org", 09:19:09 INFO - "installer_path": "public/build/target.tar.bz2", 09:19:09 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 09:19:09 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:19:09 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 09:19:09 INFO - "stage_platform": "linux64-stylo", 09:19:09 INFO - "basedir": "/builds/slave/test", 09:19:09 INFO - "buildnumber": 152, 09:19:09 INFO - "platform": "ubuntu64_hw_stylo", 09:19:09 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:19:09 INFO - "slavebuilddir": "test", 09:19:09 INFO - "taskId": "I7E1l-m9TrOJAcVctK5pVg", 09:19:09 INFO - "branch": "mozilla-central", 09:19:09 INFO - "script_repo_revision": "production", 09:19:09 INFO - "revision": "da66c4a05fda49d457d9411a7092fed87cf9e53a", 09:19:09 INFO - "slavename": "talos-linux64-ix-002", 09:19:09 INFO - "repo_path": "mozilla-central" 09:19:09 INFO - } 09:19:09 INFO - Finding installer, test and symbols from parent task. 09:19:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I7E1l-m9TrOJAcVctK5pVg'}, attempt #1 09:19:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I7E1l-m9TrOJAcVctK5pVg'}, attempt #1 09:19:10 INFO - Task dependencies: ZCCbD-PoToKOc9-qg9Y1MA 09:19:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZCCbD-PoToKOc9-qg9Y1MA'}, attempt #1 09:19:11 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZCCbD-PoToKOc9-qg9Y1MA/artifacts/public/build/target.tar.bz2 09:19:11 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ZCCbD-PoToKOc9-qg9Y1MA/artifacts/public/build/test_packages.json 09:19:11 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZCCbD-PoToKOc9-qg9Y1MA/artifacts/public/build/target.crashreporter-symbols.zip 09:19:11 INFO - Running post-action listener: _resource_record_post_action 09:19:11 INFO - [mozharness: 2017-06-14 16:19:11.100954Z] Finished read-buildbot-config step (success) 09:19:11 INFO - [mozharness: 2017-06-14 16:19:11.101171Z] Running download-and-extract step. 09:19:11 INFO - Running pre-action listener: _resource_record_pre_action 09:19:11 INFO - Running main action method: download_and_extract 09:19:11 INFO - mkdir: /builds/slave/test/build/tests 09:19: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:19:11 INFO - trying https://queue.taskcluster.net/v1/task/ZCCbD-PoToKOc9-qg9Y1MA/artifacts/public/build/target.test_packages.json 09:19:11 INFO - Downloading https://queue.taskcluster.net/v1/task/ZCCbD-PoToKOc9-qg9Y1MA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:19:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZCCbD-PoToKOc9-qg9Y1MA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:19:11 INFO - Downloaded 989 bytes. 09:19:11 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:19:11 INFO - Using the following test package requirements: 09:19:11 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:19:11 INFO - u'common': [u'target.common.tests.zip'], 09:19:11 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:19:11 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:19:11 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:19:11 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:19:11 INFO - u'mozbase': [u'target.common.tests.zip'], 09:19:11 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:19:11 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:19:11 INFO - u'web-platform': [u'target.common.tests.zip', 09:19:11 INFO - u'target.web-platform.tests.tar.gz'], 09:19:11 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:19:11 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:19:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZCCbD-PoToKOc9-qg9Y1MA/artifacts/public/build/target.common.tests.zip 09:19:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZCCbD-PoToKOc9-qg9Y1MA/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:19:11 INFO - Fetch https://queue.taskcluster.net/v1/task/ZCCbD-PoToKOc9-qg9Y1MA/artifacts/public/build/target.common.tests.zip into memory 09:19:16 INFO - Content-Length response header: 67982890 09:19:16 INFO - Bytes received: 67982890 09:19:27 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:19:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZCCbD-PoToKOc9-qg9Y1MA/artifacts/public/build/target.common.tests.zip 09:19:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZCCbD-PoToKOc9-qg9Y1MA/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:19:27 INFO - Fetch https://queue.taskcluster.net/v1/task/ZCCbD-PoToKOc9-qg9Y1MA/artifacts/public/build/target.common.tests.zip into memory 09:19:30 INFO - Content-Length response header: 67982890 09:19:30 INFO - Bytes received: 67982890 09:19:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZCCbD-PoToKOc9-qg9Y1MA/artifacts/public/build/target.talos.tests.zip 09:19:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZCCbD-PoToKOc9-qg9Y1MA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:19:43 INFO - Fetch https://queue.taskcluster.net/v1/task/ZCCbD-PoToKOc9-qg9Y1MA/artifacts/public/build/target.talos.tests.zip into memory 09:19:44 INFO - Content-Length response header: 14450022 09:19:44 INFO - Bytes received: 14450022 09:19:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:44 INFO - trying https://queue.taskcluster.net/v1/task/ZCCbD-PoToKOc9-qg9Y1MA/artifacts/public/build/target.tar.bz2 09:19:44 INFO - Downloading https://queue.taskcluster.net/v1/task/ZCCbD-PoToKOc9-qg9Y1MA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:19:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZCCbD-PoToKOc9-qg9Y1MA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:19:47 INFO - Downloaded 61412475 bytes. 09:19:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZCCbD-PoToKOc9-qg9Y1MA/artifacts/public/build/target.tar.bz2 09:19:47 INFO - mkdir: /builds/slave/test/properties 09:19:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:19:47 INFO - Writing to file /builds/slave/test/properties/build_url 09:19:47 INFO - Contents: 09:19:47 INFO - build_url:https://queue.taskcluster.net/v1/task/ZCCbD-PoToKOc9-qg9Y1MA/artifacts/public/build/target.tar.bz2 09:19:47 INFO - Running post-action listener: _resource_record_post_action 09:19:47 INFO - Running post-action listener: set_extra_try_arguments 09:19:47 INFO - [mozharness: 2017-06-14 16:19:47.660718Z] Finished download-and-extract step (success) 09:19:47 INFO - [mozharness: 2017-06-14 16:19:47.660942Z] Running populate-webroot step. 09:19:47 INFO - Running pre-action listener: _resource_record_pre_action 09:19:47 INFO - Running main action method: populate_webroot 09:19:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:19:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:19:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:19:47 INFO - '--tppagecycles', 09:19:47 INFO - '7'], 09:19:47 INFO - 'tests': ['tsvgm']}}, 09:19:47 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:19:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:19:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:19:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:19:47 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:19:47 INFO - 'talos_options': ['--disable-e10s'], 09:19:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:19:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:19:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:19:47 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:19:47 INFO - 'talos_options': ['--disable-e10s'], 09:19:47 INFO - 'tests': ['damp', 'tps']}, 09:19:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:19:47 INFO - 'tests': ['damp', 'tps']}, 09:19:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:19:47 INFO - 'tests': ['dromaeo_dom']}, 09:19:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:19:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:19:47 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:19:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:19:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:19:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:19:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:19:47 INFO - 'tests': ['a11yr', 09:19:47 INFO - 'ts_paint', 09:19:47 INFO - 'tpaint', 09:19:47 INFO - 'sessionrestore', 09:19:47 INFO - 'sessionrestore_no_auto_restore', 09:19:47 INFO - 'tabpaint']}, 09:19:47 INFO - 'other-e10s': {'tests': ['a11yr', 09:19:47 INFO - 'ts_paint', 09:19:47 INFO - 'tpaint', 09:19:47 INFO - 'sessionrestore', 09:19:47 INFO - 'sessionrestore_no_auto_restore', 09:19:47 INFO - 'tabpaint']}, 09:19:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:19:47 INFO - 'ts_paint', 09:19:47 INFO - 'tpaint', 09:19:47 INFO - 'sessionrestore', 09:19:47 INFO - 'sessionrestore_no_auto_restore', 09:19:47 INFO - 'tabpaint']}, 09:19:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:19:47 INFO - 'ts_paint', 09:19:47 INFO - 'tpaint', 09:19:47 INFO - 'sessionrestore', 09:19:47 INFO - 'sessionrestore_no_auto_restore', 09:19:47 INFO - 'tabpaint']}, 09:19:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:19:47 INFO - 'tests': ['a11yr', 09:19:47 INFO - 'ts_paint', 09:19:47 INFO - 'tpaint', 09:19:47 INFO - 'sessionrestore', 09:19:47 INFO - 'sessionrestore_no_auto_restore', 09:19:47 INFO - 'tabpaint']}, 09:19:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:19:47 INFO - 'tests': ['a11yr', 09:19:47 INFO - 'ts_paint', 09:19:47 INFO - 'tpaint', 09:19:47 INFO - 'sessionrestore', 09:19:47 INFO - 'sessionrestore_no_auto_restore', 09:19:47 INFO - 'tabpaint']}, 09:19:47 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:19:47 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:19:47 INFO - 'bloom_basic_ref']}, 09:19:47 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:19:47 INFO - 'talos_options': ['--mitmproxy', 09:19:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:19:47 INFO - '--firstNonBlankPaint'], 09:19:47 INFO - 'tests': ['quantum_pageload_google', 09:19:47 INFO - 'quantum_pageload_youtube', 09:19:47 INFO - 'quantum_pageload_amazon', 09:19:47 INFO - 'quantum_pageload_facebook']}, 09:19:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:19:47 INFO - 'tests': ['tsvgx', 09:19:47 INFO - 'tsvgr_opacity', 09:19:47 INFO - 'tart', 09:19:47 INFO - 'tscrollx', 09:19:47 INFO - 'cart', 09:19:47 INFO - 'tsvg_static']}, 09:19:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:19:47 INFO - 'tsvgr_opacity', 09:19:47 INFO - 'tart', 09:19:47 INFO - 'tscrollx', 09:19:47 INFO - 'cart', 09:19:47 INFO - 'tsvg_static']}, 09:19:47 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:19:47 INFO - 'talos_options': ['--disable-e10s'], 09:19:47 INFO - 'tests': ['tp5o']}, 09:19:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:19:47 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:19:47 INFO - 'talos_options': ['--disable-e10s', 09:19:47 INFO - '--xperf_path', 09:19:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:19:47 INFO - 'tests': ['tp5n']}, 09:19:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:19:47 INFO - 'talos_options': ['--xperf_path', 09:19:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:19:47 INFO - 'tests': ['tp5n']}}, 09:19:47 INFO - 'talos.zip': {'path': '', 09:19:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:19:47 INFO - Running post-action listener: _resource_record_post_action 09:19:47 INFO - [mozharness: 2017-06-14 16:19:47.678440Z] Finished populate-webroot step (success) 09:19:47 INFO - [mozharness: 2017-06-14 16:19:47.678530Z] Running create-virtualenv step. 09:19:47 INFO - Running pre-action listener: _resource_record_pre_action 09:19:47 INFO - Running main action method: create_virtualenv 09:19:47 INFO - Creating virtualenv /builds/slave/test/build/venv 09:19:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:19:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:19:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:19:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:19:47 INFO - Using real prefix '/usr' 09:19:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:19:48 INFO - Installing distribute.............................................................................................................................................................................................done. 09:19:50 INFO - Installing pip.................done. 09:19:50 INFO - Return code: 0 09:19:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:19:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:19:50 INFO - Reading from file tmpfile_stdout 09:19:50 INFO - Output received: 09:19:50 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:19:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:19:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc1e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9c9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9a140>, '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 0xf9aa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9aed0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1497448790.253951-1184151064', '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:19:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:19:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:19:50 INFO - Using env: {'DISPLAY': ':0', 09:19:50 INFO - 'HOME': '/home/cltbld', 09:19:50 INFO - 'LANG': 'en_US.UTF-8', 09:19:50 INFO - 'LANGUAGE': 'en_US:en', 09:19:50 INFO - 'LOGNAME': 'cltbld', 09:19:50 INFO - 'MAIL': '/var/mail/cltbld', 09:19:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:50 INFO - 'MOZ_NO_REMOTE': '1', 09:19:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:50 INFO - 'NO_EM_RESTART': '1', 09:19:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:50 INFO - 'PWD': '/builds/slave/test', 09:19:50 INFO - 'SHELL': '/bin/bash', 09:19:50 INFO - 'SHLVL': '1', 09:19:50 INFO - 'TERM': 'linux', 09:19:50 INFO - 'TMOUT': '86400', 09:19:50 INFO - 'USER': 'cltbld', 09:19:50 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1497448790.253951-1184151064', 09:19:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:50 INFO - '_': '/tools/buildbot/bin/python'} 09:19:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:19:50 INFO - Cleaning up... 09:19:50 INFO - Return code: 0 09:19:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:19:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc1e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9c9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9a140>, '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 0xf9aa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9aed0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1497448790.253951-1184151064', '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:19:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:19:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:19:50 INFO - Using env: {'DISPLAY': ':0', 09:19:50 INFO - 'HOME': '/home/cltbld', 09:19:50 INFO - 'LANG': 'en_US.UTF-8', 09:19:50 INFO - 'LANGUAGE': 'en_US:en', 09:19:50 INFO - 'LOGNAME': 'cltbld', 09:19:50 INFO - 'MAIL': '/var/mail/cltbld', 09:19:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:50 INFO - 'MOZ_NO_REMOTE': '1', 09:19:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:50 INFO - 'NO_EM_RESTART': '1', 09:19:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:50 INFO - 'PWD': '/builds/slave/test', 09:19:50 INFO - 'SHELL': '/bin/bash', 09:19:50 INFO - 'SHLVL': '1', 09:19:50 INFO - 'TERM': 'linux', 09:19:50 INFO - 'TMOUT': '86400', 09:19:50 INFO - 'USER': 'cltbld', 09:19:50 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1497448790.253951-1184151064', 09:19:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:50 INFO - '_': '/tools/buildbot/bin/python'} 09:19:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:50 INFO - Downloading/unpacking psutil>=3.1.1 09:19:50 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:19:50 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:19:50 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:19:50 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:19:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:19:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:19:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:19:52 INFO - Installing collected packages: psutil 09:19:52 INFO - Running setup.py install for psutil 09:19:52 INFO - building 'psutil._psutil_linux' extension 09:19:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:19:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:19:52 INFO - building 'psutil._psutil_posix' extension 09:19:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:19:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:19:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:19:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:19:52 INFO - Successfully installed psutil 09:19:52 INFO - Cleaning up... 09:19:52 INFO - Return code: 0 09:19:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:19:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc1e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9c9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9a140>, '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 0xf9aa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9aed0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1497448790.253951-1184151064', '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:19:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:19:52 INFO - Using env: {'DISPLAY': ':0', 09:19:52 INFO - 'HOME': '/home/cltbld', 09:19:52 INFO - 'LANG': 'en_US.UTF-8', 09:19:52 INFO - 'LANGUAGE': 'en_US:en', 09:19:52 INFO - 'LOGNAME': 'cltbld', 09:19:52 INFO - 'MAIL': '/var/mail/cltbld', 09:19:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:52 INFO - 'MOZ_NO_REMOTE': '1', 09:19:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:52 INFO - 'NO_EM_RESTART': '1', 09:19:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:52 INFO - 'PWD': '/builds/slave/test', 09:19:52 INFO - 'SHELL': '/bin/bash', 09:19:52 INFO - 'SHLVL': '1', 09:19:52 INFO - 'TERM': 'linux', 09:19:52 INFO - 'TMOUT': '86400', 09:19:52 INFO - 'USER': 'cltbld', 09:19:52 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1497448790.253951-1184151064', 09:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:52 INFO - '_': '/tools/buildbot/bin/python'} 09:19:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:19:52 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:19:52 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:19:52 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:19:52 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:19:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:19:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:19:53 INFO - Installing collected packages: mozsystemmonitor 09:19:53 INFO - Running setup.py install for mozsystemmonitor 09:19:54 INFO - Successfully installed mozsystemmonitor 09:19:54 INFO - Cleaning up... 09:19:54 INFO - Return code: 0 09:19:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:19:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc1e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9c9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9a140>, '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 0xf9aa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9aed0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1497448790.253951-1184151064', '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:19:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:19:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:19:54 INFO - Using env: {'DISPLAY': ':0', 09:19:54 INFO - 'HOME': '/home/cltbld', 09:19:54 INFO - 'LANG': 'en_US.UTF-8', 09:19:54 INFO - 'LANGUAGE': 'en_US:en', 09:19:54 INFO - 'LOGNAME': 'cltbld', 09:19:54 INFO - 'MAIL': '/var/mail/cltbld', 09:19:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:54 INFO - 'MOZ_NO_REMOTE': '1', 09:19:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:54 INFO - 'NO_EM_RESTART': '1', 09:19:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:54 INFO - 'PWD': '/builds/slave/test', 09:19:54 INFO - 'SHELL': '/bin/bash', 09:19:54 INFO - 'SHLVL': '1', 09:19:54 INFO - 'TERM': 'linux', 09:19:54 INFO - 'TMOUT': '86400', 09:19:54 INFO - 'USER': 'cltbld', 09:19:54 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1497448790.253951-1184151064', 09:19:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:54 INFO - '_': '/tools/buildbot/bin/python'} 09:19:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:54 INFO - Downloading/unpacking jsonschema==2.5.1 09:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:19:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:55 INFO - Downloading functools32-3.2.3-2.tar.gz 09:19:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:19:55 INFO - warning: no files found matching '*.txt' 09:19:55 INFO - no previously-included directories found matching 'build' 09:19:55 INFO - no previously-included directories found matching 'dist' 09:19:55 INFO - no previously-included directories found matching '.git*' 09:19:55 INFO - Installing collected packages: jsonschema, functools32 09:19:55 INFO - Running setup.py install for functools32 09:19:55 INFO - warning: no files found matching '*.txt' 09:19:55 INFO - no previously-included directories found matching 'build' 09:19:55 INFO - no previously-included directories found matching 'dist' 09:19:55 INFO - no previously-included directories found matching '.git*' 09:19:55 INFO - Successfully installed jsonschema functools32 09:19:55 INFO - Cleaning up... 09:19:55 INFO - Return code: 0 09:19:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:19:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xc1e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9c9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9a140>, '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 0xf9aa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9aed0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1497448790.253951-1184151064', '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:19:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:19:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:19:55 INFO - Using env: {'DISPLAY': ':0', 09:19:55 INFO - 'HOME': '/home/cltbld', 09:19:55 INFO - 'LANG': 'en_US.UTF-8', 09:19:55 INFO - 'LANGUAGE': 'en_US:en', 09:19:55 INFO - 'LOGNAME': 'cltbld', 09:19:55 INFO - 'MAIL': '/var/mail/cltbld', 09:19:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:55 INFO - 'MOZ_NO_REMOTE': '1', 09:19:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:55 INFO - 'NO_EM_RESTART': '1', 09:19:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:55 INFO - 'PWD': '/builds/slave/test', 09:19:55 INFO - 'SHELL': '/bin/bash', 09:19:55 INFO - 'SHLVL': '1', 09:19:55 INFO - 'TERM': 'linux', 09:19:55 INFO - 'TMOUT': '86400', 09:19:55 INFO - 'USER': 'cltbld', 09:19:55 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1497448790.253951-1184151064', 09:19:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:55 INFO - '_': '/tools/buildbot/bin/python'} 09:19:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:19:55 INFO - Cleaning up... 09:19:55 INFO - Return code: 0 09:19:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:19:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xc1e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9c9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9a140>, '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 0xf9aa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9aed0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1497448790.253951-1184151064', '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:19:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:19:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:19:55 INFO - Using env: {'DISPLAY': ':0', 09:19:55 INFO - 'HOME': '/home/cltbld', 09:19:55 INFO - 'LANG': 'en_US.UTF-8', 09:19:55 INFO - 'LANGUAGE': 'en_US:en', 09:19:55 INFO - 'LOGNAME': 'cltbld', 09:19:55 INFO - 'MAIL': '/var/mail/cltbld', 09:19:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:55 INFO - 'MOZ_NO_REMOTE': '1', 09:19:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:55 INFO - 'NO_EM_RESTART': '1', 09:19:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:55 INFO - 'PWD': '/builds/slave/test', 09:19:55 INFO - 'SHELL': '/bin/bash', 09:19:55 INFO - 'SHLVL': '1', 09:19:55 INFO - 'TERM': 'linux', 09:19:55 INFO - 'TMOUT': '86400', 09:19:55 INFO - 'USER': 'cltbld', 09:19:55 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1497448790.253951-1184151064', 09:19:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:55 INFO - '_': '/tools/buildbot/bin/python'} 09:19:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:56 INFO - Downloading/unpacking blobuploader==1.2.4 09:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:57 INFO - Downloading blobuploader-1.2.4.tar.gz 09:19:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:19:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:19:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:57 INFO - Downloading docopt-0.6.1.tar.gz 09:19:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:19:57 INFO - Installing collected packages: blobuploader, requests, docopt 09:19:57 INFO - Running setup.py install for blobuploader 09:19:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:19:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:19:57 INFO - Running setup.py install for requests 09:19:58 INFO - Running setup.py install for docopt 09:19:58 INFO - Successfully installed blobuploader requests docopt 09:19:58 INFO - Cleaning up... 09:19:58 INFO - Return code: 0 09:19:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc1e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9c9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9a140>, '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 0xf9aa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9aed0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1497448790.253951-1184151064', '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:19:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:19:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:19:58 INFO - Using env: {'DISPLAY': ':0', 09:19:58 INFO - 'HOME': '/home/cltbld', 09:19:58 INFO - 'LANG': 'en_US.UTF-8', 09:19:58 INFO - 'LANGUAGE': 'en_US:en', 09:19:58 INFO - 'LOGNAME': 'cltbld', 09:19:58 INFO - 'MAIL': '/var/mail/cltbld', 09:19:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:58 INFO - 'MOZ_NO_REMOTE': '1', 09:19:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:58 INFO - 'NO_EM_RESTART': '1', 09:19:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:58 INFO - 'PWD': '/builds/slave/test', 09:19:58 INFO - 'SHELL': '/bin/bash', 09:19:58 INFO - 'SHLVL': '1', 09:19:58 INFO - 'TERM': 'linux', 09:19:58 INFO - 'TMOUT': '86400', 09:19:58 INFO - 'USER': 'cltbld', 09:19:58 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1497448790.253951-1184151064', 09:19:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:58 INFO - '_': '/tools/buildbot/bin/python'} 09:19:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:19:58 INFO - Running setup.py (path:/tmp/pip-qYP0Oj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:19:58 INFO - Running setup.py (path:/tmp/pip-OyboTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:19:58 INFO - Running setup.py (path:/tmp/pip-Lk6X5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:19:58 INFO - Running setup.py (path:/tmp/pip-ruTzlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:19:58 INFO - Running setup.py (path:/tmp/pip-qlXpEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:19:59 INFO - Running setup.py (path:/tmp/pip-HEnSeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:19:59 INFO - Running setup.py (path:/tmp/pip-qCbgQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:19:59 INFO - Running setup.py (path:/tmp/pip-1LlkHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:19:59 INFO - Running setup.py (path:/tmp/pip-Jtrm8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:19:59 INFO - Running setup.py (path:/tmp/pip-edCSKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:19:59 INFO - Running setup.py (path:/tmp/pip-ZJHU3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:19:59 INFO - Running setup.py (path:/tmp/pip-H8fgOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:19:59 INFO - Running setup.py (path:/tmp/pip-3boRHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:19:59 INFO - Running setup.py (path:/tmp/pip-6C_Boh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:59 INFO - Running setup.py (path:/tmp/pip-TiBpWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:19:59 INFO - Running setup.py (path:/tmp/pip-TOi5Pv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:19:59 INFO - Running setup.py (path:/tmp/pip-BJOiv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:19:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:19:59 INFO - Running setup.py install for manifestparser 09:19:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:19:59 INFO - Running setup.py install for mozcrash 09:20:00 INFO - Running setup.py install for mozdebug 09:20:00 INFO - Running setup.py install for mozdevice 09:20:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:20:00 INFO - Running setup.py install for mozfile 09:20:00 INFO - Running setup.py install for mozhttpd 09:20:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:20:00 INFO - Running setup.py install for mozinfo 09:20:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:20:00 INFO - Running setup.py install for mozInstall 09:20:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:20:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:20:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:20:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:20:00 INFO - Running setup.py install for mozleak 09:20:00 INFO - Running setup.py install for mozlog 09:20:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:20:00 INFO - Running setup.py install for moznetwork 09:20:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:20:00 INFO - Running setup.py install for mozprocess 09:20:01 INFO - Running setup.py install for mozprofile 09:20:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:20:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:20:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:20:01 INFO - Running setup.py install for mozrunner 09:20:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:20:01 INFO - Running setup.py install for mozscreenshot 09:20:01 INFO - Running setup.py install for moztest 09:20:01 INFO - Running setup.py install for mozversion 09:20:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:20:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:20:01 INFO - Cleaning up... 09:20:01 INFO - Return code: 0 09:20:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:20: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:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20: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:20:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:01 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 0xc1e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9c9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9a140>, '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 0xf9aa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9aed0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1497448790.253951-1184151064', '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:20:01 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:20:01 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:20:01 INFO - Using env: {'DISPLAY': ':0', 09:20:01 INFO - 'HOME': '/home/cltbld', 09:20:01 INFO - 'LANG': 'en_US.UTF-8', 09:20:01 INFO - 'LANGUAGE': 'en_US:en', 09:20:01 INFO - 'LOGNAME': 'cltbld', 09:20:01 INFO - 'MAIL': '/var/mail/cltbld', 09:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:01 INFO - 'MOZ_NO_REMOTE': '1', 09:20:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:01 INFO - 'NO_EM_RESTART': '1', 09:20:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:01 INFO - 'PWD': '/builds/slave/test', 09:20:01 INFO - 'SHELL': '/bin/bash', 09:20:01 INFO - 'SHLVL': '1', 09:20:01 INFO - 'TERM': 'linux', 09:20:01 INFO - 'TMOUT': '86400', 09:20:01 INFO - 'USER': 'cltbld', 09:20:01 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1497448790.253951-1184151064', 09:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:01 INFO - '_': '/tools/buildbot/bin/python'} 09:20:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:20:01 INFO - Running setup.py (path:/tmp/pip-9tCyaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:20:01 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:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:20:01 INFO - Running setup.py (path:/tmp/pip-LuFZkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:20:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:20:02 INFO - Running setup.py (path:/tmp/pip-At1I1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:20:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:20:02 INFO - Running setup.py (path:/tmp/pip-0J3ffG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:20:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:20:02 INFO - Running setup.py (path:/tmp/pip-m5T0fy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:20:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:20:02 INFO - Running setup.py (path:/tmp/pip-mtYIWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:20:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:20:02 INFO - Running setup.py (path:/tmp/pip-sKZXuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:20:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:20:02 INFO - Running setup.py (path:/tmp/pip-WRc1jp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:20:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:20:02 INFO - Running setup.py (path:/tmp/pip-YaU2YU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:20:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:20:02 INFO - Running setup.py (path:/tmp/pip-dPvx3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:20:02 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:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:20:02 INFO - Running setup.py (path:/tmp/pip-aiVztG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:20:02 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:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:20:02 INFO - Running setup.py (path:/tmp/pip-dGTLzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:20:02 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:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:20:02 INFO - Running setup.py (path:/tmp/pip-m_6dQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:20:02 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:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:20:02 INFO - Running setup.py (path:/tmp/pip-tOTJN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:20:02 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:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:20:02 INFO - Running setup.py (path:/tmp/pip-RBkvvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:20:02 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:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:20:02 INFO - Running setup.py (path:/tmp/pip-EXga_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:20:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:20:03 INFO - Running setup.py (path:/tmp/pip-QdM1n1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:20:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:20:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:20:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:20:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:20:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:20:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:20:03 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:20:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:04 INFO - Downloading blessings-1.6.tar.gz 09:20:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:20:04 INFO - Installing collected packages: blessings 09:20:04 INFO - Running setup.py install for blessings 09:20:04 INFO - Successfully installed blessings 09:20:04 INFO - Cleaning up... 09:20:04 INFO - Return code: 0 09:20:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:20:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:20:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:20:04 INFO - Reading from file tmpfile_stdout 09:20:04 INFO - Current package versions: 09:20:04 INFO - argparse == 1.2.1 09:20:04 INFO - blessings == 1.6 09:20:04 INFO - blobuploader == 1.2.4 09:20:04 INFO - docopt == 0.6.1 09:20:04 INFO - functools32 == 3.2.3-2 09:20:04 INFO - jsonschema == 2.5.1 09:20:04 INFO - manifestparser == 1.1 09:20:04 INFO - mozInstall == 1.13 09:20:04 INFO - mozcrash == 1.0 09:20:04 INFO - mozdebug == 0.1 09:20:04 INFO - mozdevice == 0.51 09:20:04 INFO - mozfile == 1.2 09:20:04 INFO - mozhttpd == 0.7 09:20:04 INFO - mozinfo == 0.10 09:20:04 INFO - mozleak == 0.1 09:20:04 INFO - mozlog == 3.4 09:20:04 INFO - moznetwork == 0.27 09:20:04 INFO - mozprocess == 0.25 09:20:04 INFO - mozprofile == 0.28 09:20:04 INFO - mozrunner == 6.13 09:20:04 INFO - mozscreenshot == 0.1 09:20:04 INFO - mozsystemmonitor == 0.3 09:20:04 INFO - moztest == 0.8 09:20:04 INFO - mozversion == 1.4 09:20:04 INFO - psutil == 3.1.1 09:20:04 INFO - requests == 1.2.3 09:20:04 INFO - wsgiref == 0.1.2 09:20:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:20:04 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:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:04 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:20:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:04 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 0xc1e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9c9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9a140>, '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 0xf9aa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9aed0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1497448790.253951-1184151064', '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:20:04 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:20:04 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:20:04 INFO - Using env: {'DISPLAY': ':0', 09:20:04 INFO - 'HOME': '/home/cltbld', 09:20:04 INFO - 'LANG': 'en_US.UTF-8', 09:20:04 INFO - 'LANGUAGE': 'en_US:en', 09:20:04 INFO - 'LOGNAME': 'cltbld', 09:20:04 INFO - 'MAIL': '/var/mail/cltbld', 09:20:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:04 INFO - 'MOZ_NO_REMOTE': '1', 09:20:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:04 INFO - 'NO_EM_RESTART': '1', 09:20:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:04 INFO - 'PWD': '/builds/slave/test', 09:20:04 INFO - 'SHELL': '/bin/bash', 09:20:04 INFO - 'SHLVL': '1', 09:20:04 INFO - 'TERM': 'linux', 09:20:04 INFO - 'TMOUT': '86400', 09:20:04 INFO - 'USER': 'cltbld', 09:20:04 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1497448790.253951-1184151064', 09:20:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:04 INFO - '_': '/tools/buildbot/bin/python'} 09:20:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:04 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:20:04 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:20:04 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:20:04 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:20:04 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:20:04 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:20:04 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:20:04 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:20:04 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:20:04 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:20:04 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:20:04 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:20:04 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:20:04 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:20:05 INFO - Downloading marionette_driver-1.4.0.tar.gz 09:20:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 09:20:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:20:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:20:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:20:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:20:06 INFO - Installing collected packages: marionette-driver 09:20:06 INFO - Running setup.py install for marionette-driver 09:20:06 INFO - Successfully installed marionette-driver 09:20:06 INFO - Cleaning up... 09:20:06 INFO - Return code: 0 09:20:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:20:06 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:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:06 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:20:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:06 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 0xc1e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9c9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9a140>, '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 0xf9aa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9aed0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1497448790.253951-1184151064', '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:20:06 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:20:06 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:20:06 INFO - Using env: {'DISPLAY': ':0', 09:20:06 INFO - 'HOME': '/home/cltbld', 09:20:06 INFO - 'LANG': 'en_US.UTF-8', 09:20:06 INFO - 'LANGUAGE': 'en_US:en', 09:20:06 INFO - 'LOGNAME': 'cltbld', 09:20:06 INFO - 'MAIL': '/var/mail/cltbld', 09:20:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:06 INFO - 'MOZ_NO_REMOTE': '1', 09:20:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:06 INFO - 'NO_EM_RESTART': '1', 09:20:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:06 INFO - 'PWD': '/builds/slave/test', 09:20:06 INFO - 'SHELL': '/bin/bash', 09:20:06 INFO - 'SHLVL': '1', 09:20:06 INFO - 'TERM': 'linux', 09:20:06 INFO - 'TMOUT': '86400', 09:20:06 INFO - 'USER': 'cltbld', 09:20:06 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1497448790.253951-1184151064', 09:20:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:06 INFO - '_': '/tools/buildbot/bin/python'} 09:20:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:20:06 INFO - Cleaning up... 09:20:06 INFO - Return code: 0 09:20:06 INFO - Running post-action listener: _resource_record_post_action 09:20:06 INFO - Running post-action listener: _start_resource_monitoring 09:20:06 INFO - Starting resource monitoring. 09:20:06 INFO - [mozharness: 2017-06-14 16:20:06.412880Z] Finished create-virtualenv step (success) 09:20:06 INFO - [mozharness: 2017-06-14 16:20:06.413484Z] Running install step. 09:20:06 INFO - Running pre-action listener: _resource_record_pre_action 09:20:06 INFO - Running main action method: install 09:20:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:20:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:20:06 INFO - Reading from file tmpfile_stdout 09:20:06 INFO - Detecting whether we're running mozinstall >=1.0... 09:20:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:20:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:20:06 INFO - Reading from file tmpfile_stdout 09:20:06 INFO - Output received: 09:20:06 INFO - Usage: mozinstall [options] installer 09:20:06 INFO - Options: 09:20:06 INFO - -h, --help show this help message and exit 09:20:06 INFO - -d DEST, --destination=DEST 09:20:06 INFO - Directory to install application into. [default: 09:20:06 INFO - "/builds/slave/test"] 09:20:06 INFO - --app=APP Application being installed. [default: firefox] 09:20:06 INFO - mkdir: /builds/slave/test/build/application 09:20:06 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:20:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:20:24 INFO - Reading from file tmpfile_stdout 09:20:24 INFO - Output received: 09:20:24 INFO - /builds/slave/test/build/application/firefox/firefox 09:20:24 INFO - Running post-action listener: _resource_record_post_action 09:20:24 INFO - [mozharness: 2017-06-14 16:20:24.511325Z] Finished install step (success) 09:20:24 INFO - [mozharness: 2017-06-14 16:20:24.511602Z] Running setup-mitmproxy step. 09:20:24 INFO - Running pre-action listener: _resource_record_pre_action 09:20:24 INFO - Running main action method: setup_mitmproxy 09:20:24 INFO - Skipping: mitmproxy is not required 09:20:24 INFO - Running post-action listener: _resource_record_post_action 09:20:24 INFO - [mozharness: 2017-06-14 16:20:24.512712Z] Finished setup-mitmproxy step (success) 09:20:24 INFO - [mozharness: 2017-06-14 16:20:24.512942Z] Running run-tests step. 09:20:24 INFO - Running pre-action listener: _resource_record_pre_action 09:20:24 INFO - Running main action method: run_tests 09:20:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:20:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:20:24 INFO - Python 2.7.3 09:20:24 INFO - Return code: 0 09:20:24 INFO - grabbing minidump binary from tooltool 09:20:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:24 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 0xf9a140>, '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 0xf9aa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9aed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:20:24 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:20:24 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:20:24 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:20:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:20:24 INFO - Return code: 0 09:20:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:20:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:20:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:20:24 INFO - ENV: RUST_BACKTRACE is now 1 09:20:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:20:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:20:24 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/ZCCbD-PoToKOc9-qg9Y1MA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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:20:24 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/ZCCbD-PoToKOc9-qg9Y1MA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-002 --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:20:24 INFO - Using env: {'DISPLAY': ':0', 09:20:24 INFO - 'HOME': '/home/cltbld', 09:20:24 INFO - 'LANG': 'en_US.UTF-8', 09:20:24 INFO - 'LANGUAGE': 'en_US:en', 09:20:24 INFO - 'LOGNAME': 'cltbld', 09:20:24 INFO - 'MAIL': '/var/mail/cltbld', 09:20:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:20:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:20:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:24 INFO - 'MOZ_NO_REMOTE': '1', 09:20:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:20:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:24 INFO - 'NO_EM_RESTART': '1', 09:20:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:24 INFO - 'PWD': '/builds/slave/test', 09:20:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:20:24 INFO - 'RUST_BACKTRACE': '1', 09:20:24 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:20:24 INFO - 'SHELL': '/bin/bash', 09:20:24 INFO - 'SHLVL': '1', 09:20:24 INFO - 'TERM': 'linux', 09:20:24 INFO - 'TMOUT': '86400', 09:20:24 INFO - 'USER': 'cltbld', 09:20:24 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1497448790.253951-1184151064', 09:20:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:24 INFO - '_': '/tools/buildbot/bin/python'} 09:20:24 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/ZCCbD-PoToKOc9-qg9Y1MA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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:20:24 INFO - mozversion application_buildid: 20170614153332 09:20:24 INFO - mozversion application_changeset: da66c4a05fda49d457d9411a7092fed87cf9e53a 09:20:24 INFO - mozversion application_display_name: Nightly 09:20:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:20:24 INFO - mozversion application_name: Firefox 09:20:24 INFO - mozversion application_remotingname: firefox 09:20:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:20:24 INFO - mozversion application_vendor: Mozilla 09:20:24 INFO - mozversion application_version: 56.0a1 09:20:24 INFO - mozversion platform_buildid: 20170614153332 09:20:24 INFO - mozversion platform_changeset: da66c4a05fda49d457d9411a7092fed87cf9e53a 09:20:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:20:24 INFO - mozversion platform_version: 56.0a1 09:20:24 INFO - using testdate: 1497457224 09:20:24 INFO - actual date: 1497457224 09:20:24 INFO - starting webserver on 'localhost:59691' 09:20:24 INFO - SUITE-START | Running 2 tests 09:20:24 INFO - TEST-START | dromaeo_css 09:20:24 INFO - operating with platform_type : linux_ 09:20:24 INFO - Initialising browser for dromaeo_css test... 09:20:24 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59691/getInfo.html -profile /tmp/tmp7OqNrJ/profile 09:20:24 INFO - TEST-INFO | started process 8826 (/builds/slave/test/build/application/firefox/firefox http://localhost:59691/getInfo.html) 09:21:00 INFO - TEST-INFO | 8826: killed by SIGTERM 09:21:00 INFO - Browser initialized. 09:21:00 INFO - Running cycle 1/1 for dromaeo_css test... 09:21:00 INFO - TEST-INFO | started process 9056 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7OqNrJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:21:11 INFO - PID 9056 | RSS: Main: 188657664 09:21:11 INFO - PID 9056 | 09:24:12 INFO - PID 9056 | Cycle 1(1): loaded http://localhost:59691/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59691/tests/dromaeo/cssquery-ext.html) 09:24:14 INFO - PID 9056 | RSS: Main: 186707968 09:24:14 INFO - PID 9056 | 09:27:16 INFO - PID 9056 | Cycle 1(1): loaded http://localhost:59691/tests/dromaeo/cssquery-ext.html (next: http://localhost:59691/tests/dromaeo/cssquery-jquery.html) 09:27:16 INFO - PID 9056 | RSS: Main: 188854272 09:27:16 INFO - PID 9056 | 09:30:18 INFO - PID 9056 | Cycle 1(1): loaded http://localhost:59691/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59691/tests/dromaeo/cssquery-mootools.html) 09:30:19 INFO - PID 9056 | RSS: Main: 190517248 09:30:19 INFO - PID 9056 | 09:33:21 INFO - PID 9056 | Cycle 1(1): loaded http://localhost:59691/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59691/tests/dromaeo/cssquery-prototype.html) 09:33:21 INFO - PID 9056 | RSS: Main: 187871232 09:33:21 INFO - PID 9056 | 09:36:24 INFO - PID 9056 | Cycle 1(1): loaded http://localhost:59691/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59691/tests/dromaeo/cssquery-yui.html) 09:36:25 INFO - PID 9056 | RSS: Main: 192667648 09:36:25 INFO - PID 9056 | 09:39:27 INFO - PID 9056 | Cycle 1(1): loaded http://localhost:59691/tests/dromaeo/cssquery-yui.html (next: http://localhost:59691/tests/dromaeo/cssquery-dojo.html) 09:39:27 INFO - PID 9056 | RSS: Main: 189693952 09:39:27 INFO - PID 9056 | 09:39:27 INFO - PID 9056 | __start_tp_report 09:39:27 INFO - PID 9056 | _x_x_mozilla_page_load 09:39:27 INFO - PID 9056 | _x_x_mozilla_page_load_details 09:39:27 INFO - PID 9056 | |i|pagename|runs| 09:39:27 INFO - PID 9056 | |0;dojo.html;3000.7749418793596;3007.7293043626073;3050.359424520852;3063.0504543591474;3072.9231769205776;5689.402612725661;5744.31068271808;5796.855078623036;5801.158831969367;5876.618019828708;5829.329627092886;5832.766689332421;5857.912131318023;5863.530917526598;5878.647281163123;5371.892562148764;5406.432324605918;5454;5460.699661518614;5505.559555235572;5419.783208671668;5437.157240627689;5458.4814442627885;5482.725863706799;5507.586930980173;5172.715500647463;5269.446708095671;5300.496452836975;5376.919346209829;5385.138377859544;5337.759800808934;5373.650712703662;5381.5425688816495;5419.349678038621;5424.647397919162;5232.816851410221;5329.067413202674;5334.146536554172;5350.170723537858;5362.383325917531;5710.029295019856;5715.799947001835;5725.312962444492;5730.656160630334;5746.396628354005;6069.393060693939;6163.198784158076;6183.505319574423;6213.813585592439;6230.376962303779;6123.785667501616;6164.948350566454;6290.748370065192;6295.338989406138;6307.180066591313;5833.504152147115;5852.912206316909;5864.354920958691;5875.529957603381;5905.143754155623;6363;6437.388448097423;6441.0982462455295;6454;6475;5914.615549989237;6049.909251361233;6067.666278354733;6156.507479401637;6157.476614487729;5999.970000150059;6022.5483088768515;6040.818775436744;6045.78839740607;6050.667213303311;5961.5826892118;5975.37258587842;6008.158857759917;6017.308009578955;6064.575479716377;5943.405659434022;5981.431763982415;6035.155078289043;6037.818865434044;6062.484688801413;4966.180580204298;4966.453690094087;4978.427480839678;4984.576311013532;5033.446320904697;4038.495188101487;4375.649948004152;4403.647708183337;4454.621357184611;4473.105378924228;5396.865078372994;5414.539764120094;5463.071277882769;5480.794225270434;5511.944880551223;6237;6264.373562643699;6264.812055638338;6266.060090986297;6280.434760871543;5417.566594672417;5471.042567550663;5476.424975377608;5481.671099734029;5486.643368181056;5421.701806400607;5467.45325467458;5538.612297139242;5550.250716153349;5566.888662226733;5007.24891266313;6091.695415229221;6121.209103132296;6131.101423540749;6132.63204207749;6271.529635277281;6304.71628776697;6320.051992201023;6331.810045698637;6339.5562310637815;6098.664573448503;6110.602810817282;6131.816045518642;6147;6156.107364432043;6054.212952316171;6088.6042407243385;6120.785772497941;6169.074638804215;6183.412575805291;6276.184096067482;6299.275583307795;6327.367263273636;6337.65142917144;6352.714127864349;6034.487068599043;6129.724162412613;6129.725578588854;6132.477886260695;6183.907241391473;6155.076738489083;6170.413810687977;6178.505719542336;6182.412670796267;6193.38066193377;6080.743978127724;6093.360197179232;6106.419890110433;6108.297545782292;6134.693265336626;6088.847778805565;6136.510943810105;6137.662428566472;6157.415045570664;6167.074938759222;5938.465538101592;5950.851228719317;5970.611910225822;5974.312954010171;6057.545684073624 09:39:27 INFO - PID 9056 | |1;ext.html;717.7380256206483;748.5433885329951;764.9158592554818;786.0292538714688;787.6416230615071;36211.818940905294;37062.62937370625;37103;37377.06557336071;37389.25221495568;33396.499052514235;33983.83008084962;34030.149246268855;34069.48895766566;34175;6272.435480806726;6336.714847831836;6353.491720662336;6358.141650877142;6376.362363763633;6342.936570634304;6391.233052033739;6392.3288054754275;6394.7761828336015;6442.516811239152;6351.9682401587925;6382.521310901678;6420.133282006916;6446.355364463539;6450.3549645035355;6331.8417039573915;6332.873342533124;6337.081123237128;6342.4926005919415;6401.199850018771;5794.710264486759;5863.2670916135485;5875.2949646042325;6344.460720838734;6552.901706474407;36038.27923441517;36214.81892590546;36309.81845090784;36337.818310908275;36465.63534364649;3447.6035255945635;3503.4744788281705;3506.4389697648508;3514.8066856322894;3519.577650681909;28568.142955711362;28653.71346286531;28674;28711.85644071787;28740.712592874013;3459.15250763562;3463.9826800866085;3488.529048578435;3513.3149035938004;3563.3051554946537;146627.266863665;147881;148272;169733;170314;42851.571484285385;43504;43712.78143609325;43734.343984840256;43740.37557746546;45064.54935450669;45382;45627.315590266175;45629.54370456319;45665.543344566795;14701.705965880623;14788.852111478747;14897.18065506386;14897.255137243095;14922.776158357634;12166.148369614219;12201.145919785708;12244.081693872995;12260.26438413698;12319.75360492803;13655.317234138452;13684.863151368558;13802;13865.792013119812;13978.86021139796;5378.623496355296;5451.155070964007;5491.835244942658;5520.585956053312;5566.944330556643;970.5583959298502;981.2248323824099;1012.427978192319;1012.8025035118081;1028.7993841200894;21797.128114875228;22114.778852211595;22338.66492002621;22376.888115559643;22385.552288954128;1045.581767293089;1089.8964598363143;1097.5884043483693;1138.6014894786758;1146.60442147459;14728.410863565337;15696.76454853178;15990.280437380346;16003.359865605478;16286.429974951057;198524;198710;199294;199553;200370;54241.1863822043;54583.45416545863;54701.179482307794;54780.72609636926;54803.17795233075;1412.180935057664;1419.700085860912;1421.7085497472992;1439.5753252790244;1464.8535146485267;24680;27063.83489320889;27348.589771153052;27554.448911021267;27895.860520697268;34838.47742283817;35078.824605876805;35166.296674066885;35207.823960881055;35245.47131792974;163203;163454;164045;164192;164375;27684.169474915783;28279.29301767472;28333.016688831583;28348;32969.83515082505;37042.8147859259;37134.25731485409;37276.813615931744;37989;39021.21957560776;27648.861755691094;28067.43865122727;28379;28444;29677.851610742673;27800.165995020183;27963.300917477227;28371.858140709166;29213.269668258465;29418.262334248273;29870;31436.371272574877;31598.684013159575;31735.365292693554;31764.205894852814;26624.889769094512;27630.861845690644;28274.57588136221;29764.40471190521;31077;23879.16422925189;23915.282541523782;23984.560926344475;24398.512029759662;24896 09:39:27 INFO - PID 9056 | |2;jquery.html;465.9650526210533;471.6580479152617;481.5521564944601;487.9630784582762;496.9279454479101;14336.139831610111;19332;19973.101210445548;20263.797362026377;20289.898550507263;16963.66072678549;17318.134093295346;17465.214065367058;17528.737068943978;18336.449906502792;5884.970575147129;6056.788012419566;6062.03007518797;6072.787452439144;6102.084687296897;5933.792317268896;6041.456268935817;6042.395760423967;6042.637441753509;6049.788257410992;5991.2510936132985;5995.640261584297;5999.730012149464;6007.4593286604195;6009.09863520471;5342.813001544947;5608.327000759935;5876.97061514694;5922.052471604523;6016.127661489081;5409.43200963897;5424.484673955968;5433.212184233264;5434.3207099112615;5441.455854414567;24766.38084047913;25095.749042509524;25100;25114.748852511424;25123.62314565283;1885.27416944476;1904.457229689532;1907.4087033019807;1912.4358314297315;1920.1167462967053;15377.769333460006;16427.671446571003;16742.58143546409;17057.48827535176;17218.397356092475;2191.912323507058;2206.6248737714627;2207.4812419081504;2213.302809614966;2219.04581030157;99903;102824;103113.48443257736;109273;115532.99999999916;11614.477348519336;11724.120690948213;12274.938625306995;12300;12777.680557986125;18786.436406907815;18854.15156317969;18864.434066978014;18997.43007709771;19009.14458849355;8793.472391656522;8869.467831930106;9007.23438507721;9180.724578262663;9242.676506322381;8711.782205444788;8744.78138046554;8782.736517904474;8794.824103518022;8872.600732967032;7842;8024.879626805603;8078.798030049178;8096.392770542233;8131.18688131194;2327.453048533593;2328.87191204482;2352.3295860679623;2428.2836563213896;2512.015507748858;925.1997022575424;932.7481579973505;938.5729493080632;989.8465737810651;1004.3120462483076;17569.912150439166;17611.911940440215;17828.286868525112;18121.818781812275;18420.263189472273;960.9327347085637;982.189693502863;1002.3284399452384;1012.2711647613706;1019.4749703902496;9849.901500984899;10147.594096236067;10224;10337.328073675188;10448.007439293255;387696;406623;408901;416241;416834;99954;100318;100365;101100;101212.49393752984;999.8200323941614;1030.6547306652355;1033.834586466177;1152.8386025956372;1167.959121430763;16361.67276654484;18228;18744.53138671544;18782.624347513247;19169.32907348236;45308.32037519374;45539.772301138284;46193.30710039285;46829.29756053594;46916;56585.434145658015;56697.71651141718;56929.430705692415;56960;56976.71511642415;10584;10885.129189664965;10906.400147991937;10961.451927403758;10966.17753668494;17442.91278543599;17634.647307053532;17692.646147077245;17901.19444624969;18131.184096715417;14260.572182834532;14468.565943021305;14671.193084380035;14723.631909202355;14907.403703852158;12132.575359862363;12861.614151575468;13060.346982651019;13174.341282936006;13180.27508487004;14287.42850285977;14467.85532144665;14481.131132131684;14481.782773258199;14991.100533967996;11228.943855280671;11277.605283815026;11335.149863760085;11335.489902954221;11347.092232621535;14482.98619096653;14569.34437950316;14602.269886505845;14603.123812571279;14672.60610242068 09:39:27 INFO - PID 9056 | |3;mootools.html;1277.8722127787223;1319.571139379702;1334.9666258343534;1343.3350491506706;1350.4058214385666;11755.882441175585;12218.93890530546;12293.877061229385;12296.200746951441;12309.261444313337;11712.7657446851;12147.149699521036;12149.939250303736;12200.572979945704;12214.450349734261;2275.9089636414524;2319.524497478021;2320.791128798408;2321.8955147018423;2322.779335963081;2233.4528040630066;2281.897314620846;2283.56612243674;2285.5885940530698;2292.713410823647;2227.899744511501;2237.474193564511;2247.292102987554;2258.796708296253;2293.71328583927;2221.7111775469084;2228.2980861028723;2231.6206244938317;2234.9217777377794;2245.045855511401;2205.6691496275525;2208.1608988584235;2220.7335119785566;2224.343818573525;2225.4658881868236;11634.94182529082;11840.407979601072;11885.108616853771;11894.107941904305;11930.701732456759;6548.6725663716625;6784.864302713918;6792.252852186256;6801.455883529356;6805.931940680579;3880.844766209348;4012.9398059029136;4054.6958978076764;4122.814473348706;4179.540250572434;1289.6260084575463;1322.233104799214;1323.1597935311147;1352.7835546312642;1360.7482615716124;17210.225539850737;17984.820151798445;18440.815591844177;18971.051447427573;18984.43046708601;5040.395152581714;5631.887362252732;5845.357010728816;5870.092220028422;5955.285365756137;13429.39567719455;13461.057725959088;13467.932660336635;13471.191728496322;13566.389512471962;6705.362990515893;6718;6777.2545020047755;6777.72889084441;6792.796216113525;6292.402221788922;6365.745370185141;6397.840053998687;6401.935980640134;6413.390727880937;4291.3777502262;4526.79629416677;4550.044490656999;4578.198815207392;4598.793054312564;1340.5978206538;1367.1045465220298;1384.4047059764398;1386.7989141574415;1401.7454378331336;689.290031267795;692.5325405351367;704.8378872859271;710.722818100941;719.8308397526577;5263.4473380295285;5311.150215965427;5466.098093814476;5544.584156188302;5646.124850648156;656.5732274021829;666.8032930285481;674.3728332650682;685.3352248319122;699.2029086841005;3897.7466464679705;4000.179963107556;4027.033511957109;4089.672826173899;4092.6725861930972;15003.624909377135;15699.921500392426;16216;16223;16238.188090595422;15411.845881541041;15645.295961681752;15800.130992795506;15989.840101599068;16188.919055404647;8584;9080.182783549511;9145.176934075833;9151.405158664798;9231.215346695606;6285.49716022708;6486.902696459651;6805.829854253485;6823.317668233137;6992.265812089658;13293.20240785556;14197.219152946687;14433.711325773216;14596.197209153599;14927.0297430671;14181.361838717488;14751.483698070517;14837.10977341363;14871;14958.850411495745;10196.694099177037;10332.276740628084;10337.328073675488;10403.791924161626;10529.57881684724;11405.372704501;11591.942040289745;11604.361760102938;11615.6515304541;11624.6512604622;9402.367152111548;9555.331126821056;9589.712308630753;9649.614015439585;10089.747756306151;8968.23769979559;9371.85942210881;9389.671361502315;9594.760130996501;9866;7702.306792388712;7800.375969922506;7841.725539606086;7869.449138560246;7873.685052597832;5535.114381698909;5569.526590239713;5854.180414741854;5863.149843272787;5931.495822855106;5553.611247212818;5554.833354999357;5574.108142697149;5709;5873.588848780544 09:39:27 INFO - PID 9056 | |4;prototype.html;433.986980390588;443.27745774387745;448.10602847319603;472.1454167956;473.6447664251811;6016.4885984691355;6127.632342059474;6160.552270216501;6194.876102477948;6205.255369355672;5961.910571341434;5963.135345374918;5981.820545383634;5995.400459954013;6010.489108425789;4870.43989941156;4883.316335713003;4898.559129678329;4907.9263811042865;4908.312836202935;4824.372831531896;4832.9275060874115;4838.346823178878;4909.214525675892;4914.746739581419;4742.506110575175;4771.832985845496;4794.520547945195;4799.18413869643;4806.87982800431;4588.632909367243;4749.738764367976;4756.120117778222;4756.952430475721;4766.332713420124;4218.789060546991;4225.598568136023;4228.323468245066;4239.97880010598;4257.551907653112;5820.708964551798;5852.414758524156;5889.734961926723;5896.823095307148;5937.318862305398;5406.729663516809;5424.213489044106;5439.619226654097;5444.346678398578;5471.480209380143;6398.9040164397575;6403.967980160116;6405.359464053604;6408.23101227851;6408.854127647686;4622.237330840408;4627.6529260305615;4636.53634636537;4636.582707556337;4656.4412270527755;6696.46428285736;6789.25318214996;6800.523963322569;6807.965960170217;6854.657267136673;4719;4743.335932969387;4746.5490778376;4761.40482439695;4770.475247722748;4773.11697335994;4775.044991001813;4779.713217206979;4787.880302992384;4799.6400269979895;5426.5309284276345;5439.211314359396;5458.5087342139395;5459.836204913859;5465.016297066487;6473.741050357933;6473.76655054015;6474.514411419163;6493;6499;1637.9181040947906;1689.5776055986003;1696.1010664347668;1708.1459270364817;1710.2133018811237;1071.3250652089134;1130.7851508213414;1150.4592841364545;1169.912256580743;1174.2954227463454;5694.6583205007;5706.2011318414625;5721.399253078367;5727;5734.942650573525;6591.802245932629;6622.933770662328;6642;6653.702528007089;6660.800175994728;5664.26364572603;5693.829185124453;5720.742566584514;5737.340205876294;5744.903110364687;3477.930441391158;3517.419625761772;3522.559680039995;3537.327907697529;3540.398132317512;6382.957453614798;6391.456726178327;6420.629169685953;6438.871222575523;6444.709988050549;6730.495212859055;6823.38589526945;6838.93161068383;6839.589624622538;6849.828754281183;6278.937210627927;6377.489800815923;6399.6800159992745;6432;6464.547481676332;6506.804795856132;6551.641409092627;6572.342765723581;6572.4084832365315;6588.143541339595;6213.689315534296;6543.803685889431;6564.5076619252795;6568.868622627616;6571.638559879252;6272.498200143887;6377.681115944277;6410.519211059096;6438.774642887476;6487.18910136233;5194.844154675366;5208;5239.345081864767;5254;5264.763085661078;6634.170728658918;6636.668166591748;6681.9642955342;6685.699143538455;6690.899636505359;6191.938080619317;6423.903641445476;6450.451711604566;6454.48364130859;6476;6355.332690067661;6374.908169537678;6384.680765961591;6400.775972840928;6406.807795766134;6276.905846412216;6286.559940804283;6323.691852473906;6327.3356297589935;6357.8728425432155;6401.079676097059;6423.357664233727;6456.418922297016;6456.709448074754;6468.579542329733;6150.538709596887;6153.72308246139;6171.197744293213;6175.660338681416;6208.1308616792785 09:39:27 INFO - PID 9056 | |5;yui.html;800.1358532784592;803.8794180872865;828.0849661124457;828.465639662418;836.514821403586;16761.916190419048;17159.656806863888;17488;17516.124193790307;17526.737098943493;14563.92718036411;14744;17294.2217600208;17321.82678173218;18591.070446477657;982.351647912378;999.4153420249163;1000.5247507433984;1003.8243307421172;1004.5730564510054;975.4586204656413;975.795083032564;980.1864452504404;982.4694664880991;984.2913102566141;1054.8628678271814;1069.8716154061524;1070.454068425101;1071.59815069349;1072.5924148823435;725.7314793526376;744.7170075371379;748.8801791713299;1047.2564479219764;1056.3081181825878;729.9379552738023;747.1295940229626;751.8984937033485;751.9248075192492;755.958422286774;17508.387206447715;17658.470245892644;17667;17718;17734;17219.569510762205;18735.34426295073;18881.244750209975;18991.81008189914;19084;13825.71133907616;14579.343929523196;14637.268136593235;14853.108813471119;14860.62848428787;3515.1212196950764;3543.344481270973;3547.7161827053774;3548.556430446194;3548.591911930135;92676;94347;96520;98565.5071724644;101045;14734.336954837057;14947.177905215318;15064.472743453927;15119.319630616648;15202.011869228465;25725.614115788278;27571.035013774825;27579.448411031666;27602.309942251606;27909.023184188864;8080.111187769341;8131.634076466573;8152.38857085721;8174.059983101901;8182.304504117098;3866.555346135174;3891.883243502643;3902.941455878164;3905.5313362396696;3929.135590170158;4385.583369579885;4446.510883802779;4486.66350023743;4491.079328737666;4498.977505112453;783.2676447521585;813.7558732380262;822.6257053040852;826.7974346285079;827.3215962910476;673.71030456904;675.8209074595236;681.7409384433884;700.6251655364356;708.9078419805393;10474.68575942723;11836.763264734656;12448.564300249629;12482.563110291096;12502.679287982304;669.4430389600273;690.8514669346115;693.7606525748608;704.5385272646322;712.4585315160411;4979.3526841510375;5077.847664570068;5088.516590923857;5195.441367589783;5225.686458812484;83628.58185709154;89610.55194724115;90429;93827;95049;76008;84438.15561844302;86168;87259;89592;72415;72674;79315.60342198252;81610;82044.58977705073;11150.55397784112;11399.487023083815;11514.30914145154;12410.441530130985;12612.49550017989;29792.10623681293;30017;30536.389272213986;30588.388232235677;32460;58554;59199.70400148144;61791;62571.687141564;62722;17790;18556.072196389858;18760.812391875905;18816.435506934813;18919.71620425667;20011.899940500203;20661.17355305831;20986.790132098482;21012.63417877833;21094.15623375109;18077.276908923497;18210;18367.540811479284;18474.722879156554;18554.628907421506;17257.65484690274;17817.73273400926;17911;17937.910310448366;17997.910010449865;16404.917975410048;17186.742198866777;17357.826421736125;17486.562835929202;18654.906725466284;12067.698307542381;12080.818787718015;12484.750304993668;12716.554920577735;13098.541551045668;13450.26023568713;13469.865301346861;13818.309084545934;13922.51271205503;14685.926570367079 09:39:27 INFO - PID 9056 | __end_tp_report 09:39:27 INFO - PID 9056 | __start_cc_report 09:39:27 INFO - PID 9056 | _x_x_mozilla_cycle_collect,392 09:39:27 INFO - PID 9056 | __end_cc_report 09:39:27 INFO - PID 9056 | __startTimestamp1497458367360__endTimestamp 09:39:27 INFO - PID 9056 | 09:39:27 INFO - PID 9056 | ------- Summary: start ------- 09:39:27 INFO - PID 9056 | Number of tests: 6 09:39:27 INFO - PID 9056 | 09:39:27 INFO - PID 9056 | [#0] dojo.html Cycles:165 Average:5741.31 Median:5974.31 stddev:657.39 (11.0%) stddev-sans-first:623.27 09:39:27 INFO - PID 9056 | Values: 3000.8 3007.7 3050.4 3063.1 3072.9 5689.4 5744.3 5796.9 5801.2 5876.6 5829.3 5832.8 5857.9 5863.5 5878.6 5371.9 5406.4 5454.0 5460.7 5505.6 5419.8 5437.2 5458.5 5482.7 5507.6 5172.7 5269.4 5300.5 5376.9 5385.1 5337.8 5373.7 5381.5 5419.3 5424.6 5232.8 5329.1 5334.1 5350.2 5362.4 5710.0 5715.8 5725.3 5730.7 5746.4 6069.4 6163.2 6183.5 6213.8 6230.4 6123.8 6164.9 6290.7 6295.3 6307.2 5833.5 5852.9 5864.4 5875.5 5905.1 6363.0 6437.4 6441.1 6454.0 6475.0 5914.6 6049.9 6067.7 6156.5 6157.5 6000.0 6022.5 6040.8 6045.8 6050.7 5961.6 5975.4 6008.2 6017.3 6064.6 5943.4 5981.4 6035.2 6037.8 6062.5 4966.2 4966.5 4978.4 4984.6 5033.4 4038.5 4375.6 4403.6 4454.6 4473.1 5396.9 5414.5 5463.1 5480.8 5511.9 6237.0 6264.4 6264.8 6266.1 6280.4 5417.6 5471.0 5476.4 5481.7 5486.6 5421.7 5467.5 5538.6 5550.3 5566.9 5007.2 6091.7 6121.2 6131.1 6132.6 6271.5 6304.7 6320.1 6331.8 6339.6 6098.7 6110.6 6131.8 6147.0 6156.1 6054.2 6088.6 6120.8 6169.1 6183.4 6276.2 6299.3 6327.4 6337.7 6352.7 6034.5 6129.7 6129.7 6132.5 6183.9 6155.1 6170.4 6178.5 6182.4 6193.4 6080.7 6093.4 6106.4 6108.3 6134.7 6088.8 6136.5 6137.7 6157.4 6167.1 5938.5 5950.9 5970.6 5974.3 6057.5 09:39:27 INFO - PID 9056 | 09:39:27 INFO - PID 9056 | [#1] ext.html Cycles:180 Average:33233.02 Median:31749.79 stddev:45110.54 (142.1%) stddev-sans-first:45171.01 09:39:27 INFO - PID 9056 | Values: 717.7 748.5 764.9 786.0 787.6 36211.8 37062.6 37103.0 37377.1 37389.3 33396.5 33983.8 34030.1 34069.5 34175.0 6272.4 6336.7 6353.5 6358.1 6376.4 6342.9 6391.2 6392.3 6394.8 6442.5 6352.0 6382.5 6420.1 6446.4 6450.4 6331.8 6332.9 6337.1 6342.5 6401.2 5794.7 5863.3 5875.3 6344.5 6552.9 36038.3 36214.8 36309.8 36337.8 36465.6 3447.6 3503.5 3506.4 3514.8 3519.6 28568.1 28653.7 28674.0 28711.9 28740.7 3459.2 3464.0 3488.5 3513.3 3563.3 146627.3 147881.0 148272.0 169733.0 170314.0 42851.6 43504.0 43712.8 43734.3 43740.4 45064.5 45382.0 45627.3 45629.5 45665.5 14701.7 14788.9 14897.2 14897.3 14922.8 12166.1 12201.1 12244.1 12260.3 12319.8 13655.3 13684.9 13802.0 13865.8 13978.9 5378.6 5451.2 5491.8 5520.6 5566.9 970.6 981.2 1012.4 1012.8 1028.8 21797.1 22114.8 22338.7 22376.9 22385.6 1045.6 1089.9 1097.6 1138.6 1146.6 14728.4 15696.8 15990.3 16003.4 16286.4 198524.0 198710.0 199294.0 199553.0 200370.0 54241.2 54583.5 54701.2 54780.7 54803.2 1412.2 1419.7 1421.7 1439.6 1464.9 24680.0 27063.8 27348.6 27554.4 27895.9 34838.5 35078.8 35166.3 35207.8 35245.5 163203.0 163454.0 164045.0 164192.0 164375.0 27684.2 28279.3 28333.0 28348.0 32969.8 37042.8 37134.3 37276.8 37989.0 39021.2 27648.9 28067.4 28379.0 28444.0 29677.9 27800.2 27963.3 28371.9 29213.3 29418.3 29870.0 31436.4 31598.7 31735.4 31764.2 26624.9 27630.9 28274.6 29764.4 31077.0 23879.2 23915.3 23984.6 24398.5 24896.0 09:39:27 INFO - PID 9056 | 09:39:27 INFO - PID 9056 | [#2] jquery.html Cycles:180 Average:28721.47 Median:10626.06 stddev:68433.91 (644.0%) stddev-sans-first:68593.00 09:39:27 INFO - PID 9056 | Values: 466.0 471.7 481.6 488.0 496.9 14336.1 19332.0 19973.1 20263.8 20289.9 16963.7 17318.1 17465.2 17528.7 18336.4 5885.0 6056.8 6062.0 6072.8 6102.1 5933.8 6041.5 6042.4 6042.6 6049.8 5991.3 5995.6 5999.7 6007.5 6009.1 5342.8 5608.3 5877.0 5922.1 6016.1 5409.4 5424.5 5433.2 5434.3 5441.5 24766.4 25095.7 25100.0 25114.7 25123.6 1885.3 1904.5 1907.4 1912.4 1920.1 15377.8 16427.7 16742.6 17057.5 17218.4 2191.9 2206.6 2207.5 2213.3 2219.0 99903.0 102824.0 103113.5 109273.0 115533.0 11614.5 11724.1 12274.9 12300.0 12777.7 18786.4 18854.2 18864.4 18997.4 19009.1 8793.5 8869.5 9007.2 9180.7 9242.7 8711.8 8744.8 8782.7 8794.8 8872.6 7842.0 8024.9 8078.8 8096.4 8131.2 2327.5 2328.9 2352.3 2428.3 2512.0 925.2 932.7 938.6 989.8 1004.3 17569.9 17611.9 17828.3 18121.8 18420.3 960.9 982.2 1002.3 1012.3 1019.5 9849.9 10147.6 10224.0 10337.3 10448.0 387696.0 406623.0 408901.0 416241.0 416834.0 99954.0 100318.0 100365.0 101100.0 101212.5 999.8 1030.7 1033.8 1152.8 1168.0 16361.7 18228.0 18744.5 18782.6 19169.3 45308.3 45539.8 46193.3 46829.3 46916.0 56585.4 56697.7 56929.4 56960.0 56976.7 10584.0 10885.1 10906.4 10961.5 10966.2 17442.9 17634.6 17692.6 17901.2 18131.2 14260.6 14468.6 14671.2 14723.6 14907.4 12132.6 12861.6 13060.3 13174.3 13180.3 14287.4 14467.9 14481.1 14481.8 14991.1 11228.9 11277.6 11335.1 11335.5 11347.1 14483.0 14569.3 14602.3 14603.1 14672.6 09:39:27 INFO - PID 9056 | 09:39:27 INFO - PID 9056 | [#3] mootools.html Cycles:180 Average:7356.13 Median:2293.21 stddev:4964.58 (216.5%) stddev-sans-first:4957.50 09:39:27 INFO - PID 9056 | Values: 1277.9 1319.6 1335.0 1343.3 1350.4 11755.9 12218.9 12293.9 12296.2 12309.3 11712.8 12147.1 12149.9 12200.6 12214.5 2275.9 2319.5 2320.8 2321.9 2322.8 2233.5 2281.9 2283.6 2285.6 2292.7 2227.9 2237.5 2247.3 2258.8 2293.7 2221.7 2228.3 2231.6 2234.9 2245.0 2205.7 2208.2 2220.7 2224.3 2225.5 11634.9 11840.4 11885.1 11894.1 11930.7 6548.7 6784.9 6792.3 6801.5 6805.9 3880.8 4012.9 4054.7 4122.8 4179.5 1289.6 1322.2 1323.2 1352.8 1360.7 17210.2 17984.8 18440.8 18971.1 18984.4 5040.4 5631.9 5845.4 5870.1 5955.3 13429.4 13461.1 13467.9 13471.2 13566.4 6705.4 6718.0 6777.3 6777.7 6792.8 6292.4 6365.7 6397.8 6401.9 6413.4 4291.4 4526.8 4550.0 4578.2 4598.8 1340.6 1367.1 1384.4 1386.8 1401.7 689.3 692.5 704.8 710.7 719.8 5263.4 5311.2 5466.1 5544.6 5646.1 656.6 666.8 674.4 685.3 699.2 3897.7 4000.2 4027.0 4089.7 4092.7 15003.6 15699.9 16216.0 16223.0 16238.2 15411.8 15645.3 15800.1 15989.8 16188.9 8584.0 9080.2 9145.2 9151.4 9231.2 6285.5 6486.9 6805.8 6823.3 6992.3 13293.2 14197.2 14433.7 14596.2 14927.0 14181.4 14751.5 14837.1 14871.0 14958.9 10196.7 10332.3 10337.3 10403.8 10529.6 11405.4 11591.9 11604.4 11615.7 11624.7 9402.4 9555.3 9589.7 9649.6 10089.7 8968.2 9371.9 9389.7 9594.8 9866.0 7702.3 7800.4 7841.7 7869.4 7873.7 5535.1 5569.5 5854.2 5863.1 5931.5 5553.6 5554.8 5574.1 5709.0 5873.6 09:39:27 INFO - PID 9056 | 09:39:27 INFO - PID 9056 | [#4] prototype.html Cycles:180 Average:5382.71 Median:5962.52 stddev:1538.50 (25.8%) stddev-sans-first:1497.30 09:39:27 INFO - PID 9056 | Values: 434.0 443.3 448.1 472.1 473.6 6016.5 6127.6 6160.6 6194.9 6205.3 5961.9 5963.1 5981.8 5995.4 6010.5 4870.4 4883.3 4898.6 4907.9 4908.3 4824.4 4832.9 4838.3 4909.2 4914.7 4742.5 4771.8 4794.5 4799.2 4806.9 4588.6 4749.7 4756.1 4757.0 4766.3 4218.8 4225.6 4228.3 4240.0 4257.6 5820.7 5852.4 5889.7 5896.8 5937.3 5406.7 5424.2 5439.6 5444.3 5471.5 6398.9 6404.0 6405.4 6408.2 6408.9 4622.2 4627.7 4636.5 4636.6 4656.4 6696.5 6789.3 6800.5 6808.0 6854.7 4719.0 4743.3 4746.5 4761.4 4770.5 4773.1 4775.0 4779.7 4787.9 4799.6 5426.5 5439.2 5458.5 5459.8 5465.0 6473.7 6473.8 6474.5 6493.0 6499.0 1637.9 1689.6 1696.1 1708.1 1710.2 1071.3 1130.8 1150.5 1169.9 1174.3 5694.7 5706.2 5721.4 5727.0 5734.9 6591.8 6622.9 6642.0 6653.7 6660.8 5664.3 5693.8 5720.7 5737.3 5744.9 3477.9 3517.4 3522.6 3537.3 3540.4 6383.0 6391.5 6420.6 6438.9 6444.7 6730.5 6823.4 6838.9 6839.6 6849.8 6278.9 6377.5 6399.7 6432.0 6464.5 6506.8 6551.6 6572.3 6572.4 6588.1 6213.7 6543.8 6564.5 6568.9 6571.6 6272.5 6377.7 6410.5 6438.8 6487.2 5194.8 5208.0 5239.3 5254.0 5264.8 6634.2 6636.7 6682.0 6685.7 6690.9 6191.9 6423.9 6450.5 6454.5 6476.0 6355.3 6374.9 6384.7 6400.8 6406.8 6276.9 6286.6 6323.7 6327.3 6357.9 6401.1 6423.4 6456.4 6456.7 6468.6 6150.5 6153.7 6171.2 6175.7 6208.1 09:39:27 INFO - PID 9056 | 09:39:27 INFO - PID 9056 | [#5] yui.html Cycles:180 Average:20660.73 Median:28850.56 stddev:26431.12 (91.6%) stddev-sans-first:26463.19 09:39:27 INFO - PID 9056 | Values: 800.1 803.9 828.1 828.5 836.5 16761.9 17159.7 17488.0 17516.1 17526.7 14563.9 14744.0 17294.2 17321.8 18591.1 982.4 999.4 1000.5 1003.8 1004.6 975.5 975.8 980.2 982.5 984.3 1054.9 1069.9 1070.5 1071.6 1072.6 725.7 744.7 748.9 1047.3 1056.3 729.9 747.1 751.9 751.9 756.0 17508.4 17658.5 17667.0 17718.0 17734.0 17219.6 18735.3 18881.2 18991.8 19084.0 13825.7 14579.3 14637.3 14853.1 14860.6 3515.1 3543.3 3547.7 3548.6 3548.6 92676.0 94347.0 96520.0 98565.5 101045.0 14734.3 14947.2 15064.5 15119.3 15202.0 25725.6 27571.0 27579.4 27602.3 27909.0 8080.1 8131.6 8152.4 8174.1 8182.3 3866.6 3891.9 3902.9 3905.5 3929.1 4385.6 4446.5 4486.7 4491.1 4499.0 783.3 813.8 822.6 826.8 827.3 673.7 675.8 681.7 700.6 708.9 10474.7 11836.8 12448.6 12482.6 12502.7 669.4 690.9 693.8 704.5 712.5 4979.4 5077.8 5088.5 5195.4 5225.7 83628.6 89610.6 90429.0 93827.0 95049.0 76008.0 84438.2 86168.0 87259.0 89592.0 72415.0 72674.0 79315.6 81610.0 82044.6 11150.6 11399.5 11514.3 12410.4 12612.5 29792.1 30017.0 30536.4 30588.4 32460.0 58554.0 59199.7 61791.0 62571.7 62722.0 17790.0 18556.1 18760.8 18816.4 18919.7 20011.9 20661.2 20986.8 21012.6 21094.2 18077.3 18210.0 18367.5 18474.7 18554.6 17257.7 17817.7 17911.0 17937.9 17997.9 16404.9 17186.7 17357.8 17486.6 18654.9 12067.7 12080.8 12484.8 12716.6 13098.5 13450.3 13469.9 13818.3 13922.5 14685.9 09:39:27 INFO - PID 9056 | -------- Summary: end -------- 09:39:27 INFO - PID 9056 | 09:39:28 INFO - TEST-INFO | 9056: exit 0 09:39:28 INFO - TEST-OK | dromaeo_css | took 1143443ms 09:39:28 INFO - TEST-START | kraken 09:39:28 INFO - operating with platform_type : linux_ 09:39:28 INFO - Initialising browser for kraken test... 09:39:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59691/getInfo.html -profile /tmp/tmpZaTkth/profile 09:39:28 INFO - TEST-INFO | started process 9484 (/builds/slave/test/build/application/firefox/firefox http://localhost:59691/getInfo.html) 09:40:03 INFO - TEST-INFO | 9484: killed by SIGTERM 09:40:03 INFO - Browser initialized. 09:40:03 INFO - Running cycle 1/1 for kraken test... 09:40:03 INFO - TEST-INFO | started process 9712 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZaTkth/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:40:15 INFO - PID 9712 | RSS: Main: 188342272 09:40:15 INFO - PID 9712 | 09:40:17 INFO - PID 9712 | Cycle 1(1): loaded http://localhost:59691/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59691/tests/kraken/driver.html?testName=audio-beat-detection) 09:40:18 INFO - PID 9712 | RSS: Main: 191705088 09:40:18 INFO - PID 9712 | 09:40:21 INFO - PID 9712 | Cycle 1(1): loaded http://localhost:59691/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59691/tests/kraken/driver.html?testName=audio-dft) 09:40:22 INFO - PID 9712 | RSS: Main: 192479232 09:40:22 INFO - PID 9712 | 09:40:25 INFO - PID 9712 | Cycle 1(1): loaded http://localhost:59691/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59691/tests/kraken/driver.html?testName=audio-fft) 09:40:25 INFO - PID 9712 | RSS: Main: 188780544 09:40:25 INFO - PID 9712 | 09:40:27 INFO - PID 9712 | Cycle 1(1): loaded http://localhost:59691/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59691/tests/kraken/driver.html?testName=audio-oscillator) 09:40:28 INFO - PID 9712 | RSS: Main: 188850176 09:40:28 INFO - PID 9712 | 09:40:30 INFO - PID 9712 | Cycle 1(1): loaded http://localhost:59691/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59691/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:40:31 INFO - PID 9712 | RSS: Main: 189210624 09:40:31 INFO - PID 9712 | 09:40:34 INFO - PID 9712 | Cycle 1(1): loaded http://localhost:59691/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59691/tests/kraken/driver.html?testName=imaging-darkroom) 09:40:35 INFO - PID 9712 | RSS: Main: 190795776 09:40:35 INFO - PID 9712 | 09:40:38 INFO - PID 9712 | Cycle 1(1): loaded http://localhost:59691/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59691/tests/kraken/driver.html?testName=imaging-desaturate) 09:40:39 INFO - PID 9712 | RSS: Main: 191987712 09:40:39 INFO - PID 9712 | 09:40:42 INFO - PID 9712 | Cycle 1(1): loaded http://localhost:59691/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59691/tests/kraken/driver.html?testName=json-parse-financial) 09:40:42 INFO - PID 9712 | RSS: Main: 191324160 09:40:42 INFO - PID 9712 | 09:40:44 INFO - PID 9712 | Cycle 1(1): loaded http://localhost:59691/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59691/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:40:44 INFO - PID 9712 | RSS: Main: 190976000 09:40:44 INFO - PID 9712 | 09:40:46 INFO - PID 9712 | Cycle 1(1): loaded http://localhost:59691/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59691/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:40:47 INFO - PID 9712 | RSS: Main: 190566400 09:40:47 INFO - PID 9712 | 09:40:49 INFO - PID 9712 | Cycle 1(1): loaded http://localhost:59691/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59691/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:40:50 INFO - PID 9712 | RSS: Main: 191537152 09:40:50 INFO - PID 9712 | 09:40:52 INFO - PID 9712 | Cycle 1(1): loaded http://localhost:59691/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59691/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:40:53 INFO - PID 9712 | RSS: Main: 190763008 09:40:53 INFO - PID 9712 | 09:40:56 INFO - PID 9712 | Cycle 1(1): loaded http://localhost:59691/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59691/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:40:57 INFO - PID 9712 | RSS: Main: 190803968 09:40:57 INFO - PID 9712 | 09:40:59 INFO - PID 9712 | Cycle 1(1): loaded http://localhost:59691/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59691/tests/kraken/driver.html?testName=ai-astar) 09:40:59 INFO - PID 9712 | RSS: Main: 192110592 09:40:59 INFO - PID 9712 | 09:40:59 INFO - PID 9712 | __start_tp_report 09:40:59 INFO - PID 9712 | _x_x_mozilla_page_load 09:40:59 INFO - PID 9712 | _x_x_mozilla_page_load_details 09:40:59 INFO - PID 9712 | |i|pagename|runs| 09:40:59 INFO - PID 9712 | |0;ai-astar;104;113;111;108;112;121;111;112;112;113 09:40:59 INFO - PID 9712 | |1;audio-beat-detection;154;123;152;176;131;152;157;128;192;124 09:40:59 INFO - PID 9712 | |2;audio-dft;164;164;163;164;166;177;175;163;164;165 09:40:59 INFO - PID 9712 | |3;audio-fft;74;75;76;172;75;75;74;75;102;75 09:40:59 INFO - PID 9712 | |4;audio-oscillator;84;83;131;84;84;84;140;82;83;135 09:40:59 INFO - PID 9712 | |5;imaging-gaussian-blur;113;115;114;118;114;114;114;114;115;113 09:40:59 INFO - PID 9712 | |6;imaging-darkroom;152;151;151;152;150;150;152;177;152;152 09:40:59 INFO - PID 9712 | |7;imaging-desaturate;95;96;95;94;99;94;95;95;95;97 09:40:59 INFO - PID 9712 | |8;json-parse-financial;57;55;55;57;54;59;54;56;61;54 09:40:59 INFO - PID 9712 | |9;json-stringify-tinderbox;55;58;55;55;55;56;56;58;56;55 09:40:59 INFO - PID 9712 | |10;stanford-crypto-aes;81;86;79;80;78;90;91;80;79;79 09:40:59 INFO - PID 9712 | |11;stanford-crypto-ccm;132;140;130;128;139;134;137;129;136;154 09:40:59 INFO - PID 9712 | |12;stanford-crypto-pbkdf2;182;191;180;180;194;193;185;186;185;185 09:40:59 INFO - PID 9712 | |13;stanford-crypto-sha256-iterative;73;73;72;72;71;69;72;70;74;76 09:40:59 INFO - PID 9712 | __end_tp_report 09:40:59 INFO - PID 9712 | __start_cc_report 09:40:59 INFO - PID 9712 | _x_x_mozilla_cycle_collect,964 09:40:59 INFO - PID 9712 | __end_cc_report 09:40:59 INFO - PID 9712 | __startTimestamp1497458459318__endTimestamp 09:40:59 INFO - PID 9712 | 09:40:59 INFO - PID 9712 | ------- Summary: start ------- 09:40:59 INFO - PID 9712 | Number of tests: 14 09:40:59 INFO - PID 9712 | 09:40:59 INFO - PID 9712 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.00 stddev:4.27 (3.8%) stddev-sans-first:3.50 09:40:59 INFO - PID 9712 | Values: 104.0 113.0 111.0 108.0 112.0 121.0 111.0 112.0 112.0 113.0 09:40:59 INFO - PID 9712 | 09:40:59 INFO - PID 9712 | [#1] audio-beat-detection Cycles:10 Average:148.90 Median:153.00 stddev:22.98 (15.0%) stddev-sans-first:24.30 09:40:59 INFO - PID 9712 | Values: 154.0 123.0 152.0 176.0 131.0 152.0 157.0 128.0 192.0 124.0 09:40:59 INFO - PID 9712 | 09:40:59 INFO - PID 9712 | [#2] audio-dft Cycles:10 Average:166.50 Median:164.50 stddev:5.10 (3.1%) stddev-sans-first:5.33 09:40:59 INFO - PID 9712 | Values: 164.0 164.0 163.0 164.0 166.0 177.0 175.0 163.0 164.0 165.0 09:40:59 INFO - PID 9712 | 09:40:59 INFO - PID 9712 | [#3] audio-fft Cycles:10 Average:87.30 Median:75.00 stddev:30.96 (41.3%) stddev-sans-first:32.46 09:40:59 INFO - PID 9712 | Values: 74.0 75.0 76.0 172.0 75.0 75.0 74.0 75.0 102.0 75.0 09:40:59 INFO - PID 9712 | 09:40:59 INFO - PID 9712 | [#4] audio-oscillator Cycles:10 Average:99.00 Median:83.50 stddev:25.17 (30.1%) stddev-sans-first:26.11 09:40:59 INFO - PID 9712 | Values: 84.0 83.0 131.0 84.0 84.0 84.0 140.0 82.0 83.0 135.0 09:40:59 INFO - PID 9712 | 09:40:59 INFO - PID 9712 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.00 stddev:1.43 (1.3%) stddev-sans-first:1.42 09:40:59 INFO - PID 9712 | Values: 113.0 115.0 114.0 118.0 114.0 114.0 114.0 114.0 115.0 113.0 09:40:59 INFO - PID 9712 | 09:40:59 INFO - PID 9712 | [#6] imaging-darkroom Cycles:10 Average:153.90 Median:152.00 stddev:8.16 (5.4%) stddev-sans-first:8.62 09:40:59 INFO - PID 9712 | Values: 152.0 151.0 151.0 152.0 150.0 150.0 152.0 177.0 152.0 152.0 09:40:59 INFO - PID 9712 | 09:40:59 INFO - PID 9712 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:1.51 (1.6%) stddev-sans-first:1.59 09:40:59 INFO - PID 9712 | Values: 95.0 96.0 95.0 94.0 99.0 94.0 95.0 95.0 95.0 97.0 09:40:59 INFO - PID 9712 | 09:40:59 INFO - PID 9712 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.50 stddev:2.35 (4.2%) stddev-sans-first:2.47 09:40:59 INFO - PID 9712 | Values: 57.0 55.0 55.0 57.0 54.0 59.0 54.0 56.0 61.0 54.0 09:40:59 INFO - PID 9712 | 09:40:59 INFO - PID 9712 | [#9] json-stringify-tinderbox Cycles:10 Average:55.90 Median:56.00 stddev:1.20 (2.1%) stddev-sans-first:1.22 09:40:59 INFO - PID 9712 | Values: 55.0 58.0 55.0 55.0 55.0 56.0 56.0 58.0 56.0 55.0 09:40:59 INFO - PID 9712 | 09:40:59 INFO - PID 9712 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:80.50 stddev:4.85 (6.0%) stddev-sans-first:5.13 09:40:59 INFO - PID 9712 | Values: 81.0 86.0 79.0 80.0 78.0 90.0 91.0 80.0 79.0 79.0 09:40:59 INFO - PID 9712 | 09:40:59 INFO - PID 9712 | [#11] stanford-crypto-ccm Cycles:10 Average:135.90 Median:136.50 stddev:7.59 (5.6%) stddev-sans-first:7.92 09:40:59 INFO - PID 9712 | Values: 132.0 140.0 130.0 128.0 139.0 134.0 137.0 129.0 136.0 154.0 09:40:59 INFO - PID 9712 | 09:40:59 INFO - PID 9712 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.10 Median:185.50 stddev:5.04 (2.7%) stddev-sans-first:5.13 09:40:59 INFO - PID 9712 | Values: 182.0 191.0 180.0 180.0 194.0 193.0 185.0 186.0 185.0 185.0 09:40:59 INFO - PID 9712 | 09:40:59 INFO - PID 9712 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.20 Median:72.50 stddev:1.99 (2.7%) stddev-sans-first:2.09 09:40:59 INFO - PID 9712 | Values: 73.0 73.0 72.0 72.0 71.0 69.0 72.0 70.0 74.0 76.0 09:40:59 INFO - PID 9712 | -------- Summary: end -------- 09:40:59 INFO - PID 9712 | 09:41:00 INFO - TEST-INFO | 9712: exit 0 09:41:00 INFO - TEST-OK | kraken | took 92290ms 09:41:00 INFO - SUITE-END | took 1235s 09:41:01 INFO - Completed test suite (00:20:36) 09:41:01 INFO - javascript benchmark 09:41:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7652.59971001642, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3000.7749418793596, 3007.7293043626073, 3050.359424520852, 3063.0504543591474, 3072.9231769205776, 5689.402612725661, 5744.31068271808, 5796.855078623036, 5801.158831969367, 5876.618019828708, 5829.329627092886, 5832.766689332421, 5857.912131318023, 5863.530917526598, 5878.647281163123, 5371.892562148764, 5406.432324605918, 5454.0, 5460.699661518614, 5505.559555235572, 5419.783208671668, 5437.157240627689, 5458.4814442627885, 5482.725863706799, 5507.586930980173, 5172.715500647463, 5269.446708095671, 5300.496452836975, 5376.919346209829, 5385.138377859544, 5337.759800808934, 5373.650712703662, 5381.5425688816495, 5419.349678038621, 5424.647397919162, 5232.816851410221, 5329.067413202674, 5334.146536554172, 5350.170723537858, 5362.383325917531, 5710.029295019856, 5715.799947001835, 5725.312962444492, 5730.656160630334, 5746.396628354005, 6069.393060693939, 6163.198784158076, 6183.505319574423, 6213.813585592439, 6230.376962303779, 6123.785667501616, 6164.948350566454, 6290.748370065192, 6295.338989406138, 6307.180066591313, 5833.504152147115, 5852.912206316909, 5864.354920958691, 5875.529957603381, 5905.143754155623, 6363.0, 6437.388448097423, 6441.0982462455295, 6454.0, 6475.0, 5914.615549989237, 6049.909251361233, 6067.666278354733, 6156.507479401637, 6157.476614487729, 5999.970000150059, 6022.5483088768515, 6040.818775436744, 6045.78839740607, 6050.667213303311, 5961.5826892118, 5975.37258587842, 6008.158857759917, 6017.308009578955, 6064.575479716377, 5943.405659434022, 5981.431763982415, 6035.155078289043, 6037.818865434044, 6062.484688801413, 4966.180580204298, 4966.453690094087, 4978.427480839678, 4984.576311013532, 5033.446320904697, 4038.495188101487, 4375.649948004152, 4403.647708183337, 4454.621357184611, 4473.105378924228, 5396.865078372994, 5414.539764120094, 5463.071277882769, 5480.794225270434, 5511.944880551223, 6237.0, 6264.373562643699, 6264.812055638338, 6266.060090986297, 6280.434760871543, 5417.566594672417, 5471.042567550663, 5476.424975377608, 5481.671099734029, 5486.643368181056, 5421.701806400607, 5467.45325467458, 5538.612297139242, 5550.250716153349, 5566.888662226733, 5007.24891266313, 6091.695415229221, 6121.209103132296, 6131.101423540749, 6132.63204207749, 6271.529635277281, 6304.71628776697, 6320.051992201023, 6331.810045698637, 6339.5562310637815, 6098.664573448503, 6110.602810817282, 6131.816045518642, 6147.0, 6156.107364432043, 6054.212952316171, 6088.6042407243385, 6120.785772497941, 6169.074638804215, 6183.412575805291, 6276.184096067482, 6299.275583307795, 6327.367263273636, 6337.65142917144, 6352.714127864349, 6034.487068599043, 6129.724162412613, 6129.725578588854, 6132.477886260695, 6183.907241391473, 6155.076738489083, 6170.413810687977, 6178.505719542336, 6182.412670796267, 6193.38066193377, 6080.743978127724, 6093.360197179232, 6106.419890110433, 6108.297545782292, 6134.693265336626, 6088.847778805565, 6136.510943810105, 6137.662428566472, 6157.415045570664, 6167.074938759222, 5938.465538101592, 5950.851228719317, 5970.611910225822, 5974.312954010171, 6057.545684073624], "value": 5694.503527863381, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.7380256206483, 748.5433885329951, 764.9158592554818, 786.0292538714688, 787.6416230615071, 36211.818940905294, 37062.62937370625, 37103.0, 37377.06557336071, 37389.25221495568, 33396.499052514235, 33983.83008084962, 34030.149246268855, 34069.48895766566, 34175.0, 6272.435480806726, 6336.714847831836, 6353.491720662336, 6358.141650877142, 6376.362363763633, 6342.936570634304, 6391.233052033739, 6392.3288054754275, 6394.7761828336015, 6442.516811239152, 6351.9682401587925, 6382.521310901678, 6420.133282006916, 6446.355364463539, 6450.3549645035355, 6331.8417039573915, 6332.873342533124, 6337.081123237128, 6342.4926005919415, 6401.199850018771, 5794.710264486759, 5863.2670916135485, 5875.2949646042325, 6344.460720838734, 6552.901706474407, 36038.27923441517, 36214.81892590546, 36309.81845090784, 36337.818310908275, 36465.63534364649, 3447.6035255945635, 3503.4744788281705, 3506.4389697648508, 3514.8066856322894, 3519.577650681909, 28568.142955711362, 28653.71346286531, 28674.0, 28711.85644071787, 28740.712592874013, 3459.15250763562, 3463.9826800866085, 3488.529048578435, 3513.3149035938004, 3563.3051554946537, 146627.266863665, 147881.0, 148272.0, 169733.0, 170314.0, 42851.571484285385, 43504.0, 43712.78143609325, 43734.343984840256, 43740.37557746546, 45064.54935450669, 45382.0, 45627.315590266175, 45629.54370456319, 45665.543344566795, 14701.705965880623, 14788.852111478747, 14897.18065506386, 14897.255137243095, 14922.776158357634, 12166.148369614219, 12201.145919785708, 12244.081693872995, 12260.26438413698, 12319.75360492803, 13655.317234138452, 13684.863151368558, 13802.0, 13865.792013119812, 13978.86021139796, 5378.623496355296, 5451.155070964007, 5491.835244942658, 5520.585956053312, 5566.944330556643, 970.5583959298502, 981.2248323824099, 1012.427978192319, 1012.8025035118081, 1028.7993841200894, 21797.128114875228, 22114.778852211595, 22338.66492002621, 22376.888115559643, 22385.552288954128, 1045.581767293089, 1089.8964598363143, 1097.5884043483693, 1138.6014894786758, 1146.60442147459, 14728.410863565337, 15696.76454853178, 15990.280437380346, 16003.359865605478, 16286.429974951057, 198524.0, 198710.0, 199294.0, 199553.0, 200370.0, 54241.1863822043, 54583.45416545863, 54701.179482307794, 54780.72609636926, 54803.17795233075, 1412.180935057664, 1419.700085860912, 1421.7085497472992, 1439.5753252790244, 1464.8535146485267, 24680.0, 27063.83489320889, 27348.589771153052, 27554.448911021267, 27895.860520697268, 34838.47742283817, 35078.824605876805, 35166.296674066885, 35207.823960881055, 35245.47131792974, 163203.0, 163454.0, 164045.0, 164192.0, 164375.0, 27684.169474915783, 28279.29301767472, 28333.016688831583, 28348.0, 32969.83515082505, 37042.8147859259, 37134.25731485409, 37276.813615931744, 37989.0, 39021.21957560776, 27648.861755691094, 28067.43865122727, 28379.0, 28444.0, 29677.851610742673, 27800.165995020183, 27963.300917477227, 28371.858140709166, 29213.269668258465, 29418.262334248273, 29870.0, 31436.371272574877, 31598.684013159575, 31735.365292693554, 31764.205894852814, 26624.889769094512, 27630.861845690644, 28274.57588136221, 29764.40471190521, 31077.0, 23879.16422925189, 23915.282541523782, 23984.560926344475, 24398.512029759662, 24896.0], "value": 15621.176671531337, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [465.9650526210533, 471.6580479152617, 481.5521564944601, 487.9630784582762, 496.9279454479101, 14336.139831610111, 19332.0, 19973.101210445548, 20263.797362026377, 20289.898550507263, 16963.66072678549, 17318.134093295346, 17465.214065367058, 17528.737068943978, 18336.449906502792, 5884.970575147129, 6056.788012419566, 6062.03007518797, 6072.787452439144, 6102.084687296897, 5933.792317268896, 6041.456268935817, 6042.395760423967, 6042.637441753509, 6049.788257410992, 5991.2510936132985, 5995.640261584297, 5999.730012149464, 6007.4593286604195, 6009.09863520471, 5342.813001544947, 5608.327000759935, 5876.97061514694, 5922.052471604523, 6016.127661489081, 5409.43200963897, 5424.484673955968, 5433.212184233264, 5434.3207099112615, 5441.455854414567, 24766.38084047913, 25095.749042509524, 25100.0, 25114.748852511424, 25123.62314565283, 1885.27416944476, 1904.457229689532, 1907.4087033019807, 1912.4358314297315, 1920.1167462967053, 15377.769333460006, 16427.671446571003, 16742.58143546409, 17057.48827535176, 17218.397356092475, 2191.912323507058, 2206.6248737714627, 2207.4812419081504, 2213.302809614966, 2219.04581030157, 99903.0, 102824.0, 103113.48443257736, 109273.0, 115532.99999999916, 11614.477348519336, 11724.120690948213, 12274.938625306995, 12300.0, 12777.680557986125, 18786.436406907815, 18854.15156317969, 18864.434066978014, 18997.43007709771, 19009.14458849355, 8793.472391656522, 8869.467831930106, 9007.23438507721, 9180.724578262663, 9242.676506322381, 8711.782205444788, 8744.78138046554, 8782.736517904474, 8794.824103518022, 8872.600732967032, 7842.0, 8024.879626805603, 8078.798030049178, 8096.392770542233, 8131.18688131194, 2327.453048533593, 2328.87191204482, 2352.3295860679623, 2428.2836563213896, 2512.015507748858, 925.1997022575424, 932.7481579973505, 938.5729493080632, 989.8465737810651, 1004.3120462483076, 17569.912150439166, 17611.911940440215, 17828.286868525112, 18121.818781812275, 18420.263189472273, 960.9327347085637, 982.189693502863, 1002.3284399452384, 1012.2711647613706, 1019.4749703902496, 9849.901500984899, 10147.594096236067, 10224.0, 10337.328073675188, 10448.007439293255, 387696.0, 406623.0, 408901.0, 416241.0, 416834.0, 99954.0, 100318.0, 100365.0, 101100.0, 101212.49393752984, 999.8200323941614, 1030.6547306652355, 1033.834586466177, 1152.8386025956372, 1167.959121430763, 16361.67276654484, 18228.0, 18744.53138671544, 18782.624347513247, 19169.32907348236, 45308.32037519374, 45539.772301138284, 46193.30710039285, 46829.29756053594, 46916.0, 56585.434145658015, 56697.71651141718, 56929.430705692415, 56960.0, 56976.71511642415, 10584.0, 10885.129189664965, 10906.400147991937, 10961.451927403758, 10966.17753668494, 17442.91278543599, 17634.647307053532, 17692.646147077245, 17901.19444624969, 18131.184096715417, 14260.572182834532, 14468.565943021305, 14671.193084380035, 14723.631909202355, 14907.403703852158, 12132.575359862363, 12861.614151575468, 13060.346982651019, 13174.341282936006, 13180.27508487004, 14287.42850285977, 14467.85532144665, 14481.131132131684, 14481.782773258199, 14991.100533967996, 11228.943855280671, 11277.605283815026, 11335.149863760085, 11335.489902954221, 11347.092232621535, 14482.98619096653, 14569.34437950316, 14602.269886505845, 14603.123812571279, 14672.60610242068], "value": 10227.924167048484, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1277.8722127787223, 1319.571139379702, 1334.9666258343534, 1343.3350491506706, 1350.4058214385666, 11755.882441175585, 12218.93890530546, 12293.877061229385, 12296.200746951441, 12309.261444313337, 11712.7657446851, 12147.149699521036, 12149.939250303736, 12200.572979945704, 12214.450349734261, 2275.9089636414524, 2319.524497478021, 2320.791128798408, 2321.8955147018423, 2322.779335963081, 2233.4528040630066, 2281.897314620846, 2283.56612243674, 2285.5885940530698, 2292.713410823647, 2227.899744511501, 2237.474193564511, 2247.292102987554, 2258.796708296253, 2293.71328583927, 2221.7111775469084, 2228.2980861028723, 2231.6206244938317, 2234.9217777377794, 2245.045855511401, 2205.6691496275525, 2208.1608988584235, 2220.7335119785566, 2224.343818573525, 2225.4658881868236, 11634.94182529082, 11840.407979601072, 11885.108616853771, 11894.107941904305, 11930.701732456759, 6548.6725663716625, 6784.864302713918, 6792.252852186256, 6801.455883529356, 6805.931940680579, 3880.844766209348, 4012.9398059029136, 4054.6958978076764, 4122.814473348706, 4179.540250572434, 1289.6260084575463, 1322.233104799214, 1323.1597935311147, 1352.7835546312642, 1360.7482615716124, 17210.225539850737, 17984.820151798445, 18440.815591844177, 18971.051447427573, 18984.43046708601, 5040.395152581714, 5631.887362252732, 5845.357010728816, 5870.092220028422, 5955.285365756137, 13429.39567719455, 13461.057725959088, 13467.932660336635, 13471.191728496322, 13566.389512471962, 6705.362990515893, 6718.0, 6777.2545020047755, 6777.72889084441, 6792.796216113525, 6292.402221788922, 6365.745370185141, 6397.840053998687, 6401.935980640134, 6413.390727880937, 4291.3777502262, 4526.79629416677, 4550.044490656999, 4578.198815207392, 4598.793054312564, 1340.5978206538, 1367.1045465220298, 1384.4047059764398, 1386.7989141574415, 1401.7454378331336, 689.290031267795, 692.5325405351367, 704.8378872859271, 710.722818100941, 719.8308397526577, 5263.4473380295285, 5311.150215965427, 5466.098093814476, 5544.584156188302, 5646.124850648156, 656.5732274021829, 666.8032930285481, 674.3728332650682, 685.3352248319122, 699.2029086841005, 3897.7466464679705, 4000.179963107556, 4027.033511957109, 4089.672826173899, 4092.6725861930972, 15003.624909377135, 15699.921500392426, 16216.0, 16223.0, 16238.188090595422, 15411.845881541041, 15645.295961681752, 15800.130992795506, 15989.840101599068, 16188.919055404647, 8584.0, 9080.182783549511, 9145.176934075833, 9151.405158664798, 9231.215346695606, 6285.49716022708, 6486.902696459651, 6805.829854253485, 6823.317668233137, 6992.265812089658, 13293.20240785556, 14197.219152946687, 14433.711325773216, 14596.197209153599, 14927.0297430671, 14181.361838717488, 14751.483698070517, 14837.10977341363, 14871.0, 14958.850411495745, 10196.694099177037, 10332.276740628084, 10337.328073675488, 10403.791924161626, 10529.57881684724, 11405.372704501, 11591.942040289745, 11604.361760102938, 11615.6515304541, 11624.6512604622, 9402.367152111548, 9555.331126821056, 9589.712308630753, 9649.614015439585, 10089.747756306151, 8968.23769979559, 9371.85942210881, 9389.671361502315, 9594.760130996501, 9866.0, 7702.306792388712, 7800.375969922506, 7841.725539606086, 7869.449138560246, 7873.685052597832, 5535.114381698909, 5569.526590239713, 5854.180414741854, 5863.149843272787, 5931.495822855106, 5553.611247212818, 5554.833354999357, 5574.108142697149, 5709.0, 5873.588848780544], "value": 5353.547267972913, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [433.986980390588, 443.27745774387745, 448.10602847319603, 472.1454167956, 473.6447664251811, 6016.4885984691355, 6127.632342059474, 6160.552270216501, 6194.876102477948, 6205.255369355672, 5961.910571341434, 5963.135345374918, 5981.820545383634, 5995.400459954013, 6010.489108425789, 4870.43989941156, 4883.316335713003, 4898.559129678329, 4907.9263811042865, 4908.312836202935, 4824.372831531896, 4832.9275060874115, 4838.346823178878, 4909.214525675892, 4914.746739581419, 4742.506110575175, 4771.832985845496, 4794.520547945195, 4799.18413869643, 4806.87982800431, 4588.632909367243, 4749.738764367976, 4756.120117778222, 4756.952430475721, 4766.332713420124, 4218.789060546991, 4225.598568136023, 4228.323468245066, 4239.97880010598, 4257.551907653112, 5820.708964551798, 5852.414758524156, 5889.734961926723, 5896.823095307148, 5937.318862305398, 5406.729663516809, 5424.213489044106, 5439.619226654097, 5444.346678398578, 5471.480209380143, 6398.9040164397575, 6403.967980160116, 6405.359464053604, 6408.23101227851, 6408.854127647686, 4622.237330840408, 4627.6529260305615, 4636.53634636537, 4636.582707556337, 4656.4412270527755, 6696.46428285736, 6789.25318214996, 6800.523963322569, 6807.965960170217, 6854.657267136673, 4719.0, 4743.335932969387, 4746.5490778376, 4761.40482439695, 4770.475247722748, 4773.11697335994, 4775.044991001813, 4779.713217206979, 4787.880302992384, 4799.6400269979895, 5426.5309284276345, 5439.211314359396, 5458.5087342139395, 5459.836204913859, 5465.016297066487, 6473.741050357933, 6473.76655054015, 6474.514411419163, 6493.0, 6499.0, 1637.9181040947906, 1689.5776055986003, 1696.1010664347668, 1708.1459270364817, 1710.2133018811237, 1071.3250652089134, 1130.7851508213414, 1150.4592841364545, 1169.912256580743, 1174.2954227463454, 5694.6583205007, 5706.2011318414625, 5721.399253078367, 5727.0, 5734.942650573525, 6591.802245932629, 6622.933770662328, 6642.0, 6653.702528007089, 6660.800175994728, 5664.26364572603, 5693.829185124453, 5720.742566584514, 5737.340205876294, 5744.903110364687, 3477.930441391158, 3517.419625761772, 3522.559680039995, 3537.327907697529, 3540.398132317512, 6382.957453614798, 6391.456726178327, 6420.629169685953, 6438.871222575523, 6444.709988050549, 6730.495212859055, 6823.38589526945, 6838.93161068383, 6839.589624622538, 6849.828754281183, 6278.937210627927, 6377.489800815923, 6399.6800159992745, 6432.0, 6464.547481676332, 6506.804795856132, 6551.641409092627, 6572.342765723581, 6572.4084832365315, 6588.143541339595, 6213.689315534296, 6543.803685889431, 6564.5076619252795, 6568.868622627616, 6571.638559879252, 6272.498200143887, 6377.681115944277, 6410.519211059096, 6438.774642887476, 6487.18910136233, 5194.844154675366, 5208.0, 5239.345081864767, 5254.0, 5264.763085661078, 6634.170728658918, 6636.668166591748, 6681.9642955342, 6685.699143538455, 6690.899636505359, 6191.938080619317, 6423.903641445476, 6450.451711604566, 6454.48364130859, 6476.0, 6355.332690067661, 6374.908169537678, 6384.680765961591, 6400.775972840928, 6406.807795766134, 6276.905846412216, 6286.559940804283, 6323.691852473906, 6327.3356297589935, 6357.8728425432155, 6401.079676097059, 6423.357664233727, 6456.418922297016, 6456.709448074754, 6468.579542329733, 6150.538709596887, 6153.72308246139, 6171.197744293213, 6175.660338681416, 6208.1308616792785], "value": 4915.267644072457, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [800.1358532784592, 803.8794180872865, 828.0849661124457, 828.465639662418, 836.514821403586, 16761.916190419048, 17159.656806863888, 17488.0, 17516.124193790307, 17526.737098943493, 14563.92718036411, 14744.0, 17294.2217600208, 17321.82678173218, 18591.070446477657, 982.351647912378, 999.4153420249163, 1000.5247507433984, 1003.8243307421172, 1004.5730564510054, 975.4586204656413, 975.795083032564, 980.1864452504404, 982.4694664880991, 984.2913102566141, 1054.8628678271814, 1069.8716154061524, 1070.454068425101, 1071.59815069349, 1072.5924148823435, 725.7314793526376, 744.7170075371379, 748.8801791713299, 1047.2564479219764, 1056.3081181825878, 729.9379552738023, 747.1295940229626, 751.8984937033485, 751.9248075192492, 755.958422286774, 17508.387206447715, 17658.470245892644, 17667.0, 17718.0, 17734.0, 17219.569510762205, 18735.34426295073, 18881.244750209975, 18991.81008189914, 19084.0, 13825.71133907616, 14579.343929523196, 14637.268136593235, 14853.108813471119, 14860.62848428787, 3515.1212196950764, 3543.344481270973, 3547.7161827053774, 3548.556430446194, 3548.591911930135, 92676.0, 94347.0, 96520.0, 98565.5071724644, 101045.0, 14734.336954837057, 14947.177905215318, 15064.472743453927, 15119.319630616648, 15202.011869228465, 25725.614115788278, 27571.035013774825, 27579.448411031666, 27602.309942251606, 27909.023184188864, 8080.111187769341, 8131.634076466573, 8152.38857085721, 8174.059983101901, 8182.304504117098, 3866.555346135174, 3891.883243502643, 3902.941455878164, 3905.5313362396696, 3929.135590170158, 4385.583369579885, 4446.510883802779, 4486.66350023743, 4491.079328737666, 4498.977505112453, 783.2676447521585, 813.7558732380262, 822.6257053040852, 826.7974346285079, 827.3215962910476, 673.71030456904, 675.8209074595236, 681.7409384433884, 700.6251655364356, 708.9078419805393, 10474.68575942723, 11836.763264734656, 12448.564300249629, 12482.563110291096, 12502.679287982304, 669.4430389600273, 690.8514669346115, 693.7606525748608, 704.5385272646322, 712.4585315160411, 4979.3526841510375, 5077.847664570068, 5088.516590923857, 5195.441367589783, 5225.686458812484, 83628.58185709154, 89610.55194724115, 90429.0, 93827.0, 95049.0, 76008.0, 84438.15561844302, 86168.0, 87259.0, 89592.0, 72415.0, 72674.0, 79315.60342198252, 81610.0, 82044.58977705073, 11150.55397784112, 11399.487023083815, 11514.30914145154, 12410.441530130985, 12612.49550017989, 29792.10623681293, 30017.0, 30536.389272213986, 30588.388232235677, 32460.0, 58554.0, 59199.70400148144, 61791.0, 62571.687141564, 62722.0, 17790.0, 18556.072196389858, 18760.812391875905, 18816.435506934813, 18919.71620425667, 20011.899940500203, 20661.17355305831, 20986.790132098482, 21012.63417877833, 21094.15623375109, 18077.276908923497, 18210.0, 18367.540811479284, 18474.722879156554, 18554.628907421506, 17257.65484690274, 17817.73273400926, 17911.0, 17937.910310448366, 17997.910010449865, 16404.917975410048, 17186.742198866777, 17357.826421736125, 17486.562835929202, 18654.906725466284, 12067.698307542381, 12080.818787718015, 12484.750304993668, 12716.554920577735, 13098.541551045668, 13450.26023568713, 13469.865301346861, 13818.309084545934, 13922.51271205503, 14685.926570367079], "value": 8388.432094238678, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1565.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 111.0, 108.0, 112.0, 121.0, 111.0, 112.0, 112.0, 113.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 123.0, 152.0, 176.0, 131.0, 152.0, 157.0, 128.0, 192.0, 124.0], "value": 148.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 163.0, 164.0, 166.0, 177.0, 175.0, 163.0, 164.0, 165.0], "value": 166.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 172.0, 75.0, 75.0, 74.0, 75.0, 102.0, 75.0], "value": 87.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 131.0, 84.0, 84.0, 84.0, 140.0, 82.0, 83.0, 135.0], "value": 99.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 118.0, 114.0, 114.0, 114.0, 114.0, 115.0, 113.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 151.0, 152.0, 150.0, 150.0, 152.0, 177.0, 152.0, 152.0], "value": 153.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 94.0, 99.0, 94.0, 95.0, 95.0, 95.0, 97.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 55.0, 57.0, 54.0, 59.0, 54.0, 56.0, 61.0, 54.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 55.0, 55.0, 55.0, 56.0, 56.0, 58.0, 56.0, 55.0], "value": 55.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 86.0, 79.0, 80.0, 78.0, 90.0, 91.0, 80.0, 79.0, 79.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 140.0, 130.0, 128.0, 139.0, 134.0, 137.0, 129.0, 136.0, 154.0], "value": 135.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 191.0, 180.0, 180.0, 194.0, 193.0, 185.0, 186.0, 185.0, 185.0], "value": 186.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 72.0, 72.0, 71.0, 69.0, 72.0, 70.0, 74.0, 76.0], "value": 72.2, "unit": "score"}]}]} 09:41:01 INFO - Return code: 0 09:41:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:41:01 INFO - # TBPL SUCCESS # 09:41:01 INFO - Running post-action listener: _resource_record_post_action 09:41:01 INFO - [mozharness: 2017-06-14 16:41:01.207297Z] Finished run-tests step (success) 09:41:01 INFO - Running post-run listener: _resource_record_post_run 09:41:01 INFO - Total resource usage - Wall time: 1254s; CPU: 13.0%; Read bytes: 196608; Write bytes: 448757760; Read time: 112; Write time: 267308 09:41:01 INFO - TinderboxPrint: CPU usage
12.7% 09:41:01 INFO - TinderboxPrint: I/O read bytes / time
196,608 / 112 09:41:01 INFO - TinderboxPrint: I/O write bytes / time
448,757,760 / 267,308 09:41:01 INFO - TinderboxPrint: CPU idle
8,730.8 (87.3%) 09:41:01 INFO - TinderboxPrint: CPU user
1,214.8 (12.1%) 09:41:01 INFO - TinderboxPrint: Swap in / out
0 / 0 09:41:01 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 118046720; Read time: 0; Write time: 87040 09:41:01 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:41:01 INFO - run-tests - Wall time: 1237s; CPU: 13.0%; Read bytes: 192512; Write bytes: 330067968; Read time: 96; Write time: 180244 09:41:01 INFO - Running post-run listener: _upload_blobber_files 09:41:01 INFO - Blob upload gear active. 09:41:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:41:01 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:41:01 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:41:01 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:41:02 INFO - (blobuploader) - INFO - Open directory for files ... 09:41:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:41:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:03 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:41:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:03 INFO - (blobuploader) - INFO - Done attempting. 09:41:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:41:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:41:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:04 INFO - (blobuploader) - INFO - Done attempting. 09:41:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:41:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:41:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:07 INFO - (blobuploader) - INFO - Done attempting. 09:41:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:41:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:41:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:08 INFO - (blobuploader) - INFO - Done attempting. 09:41:08 INFO - (blobuploader) - INFO - Iteration through files over. 09:41:08 INFO - Return code: 0 09:41:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:41:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:41:08 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d05c2d3ba6958ecd452500ae0f8a4046e9a8b58e472016cea01a17c820699f4de37c2d76c238b32e3260ebf66469dea8dd075fbbf8c57869628f6072e951dcb1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c08ee0fa3b84e4527857b4de6e0521dfeed1bd2226b8c15c427c847333b40f55a310b2b9d4caa5545f5f93d5e1fe60c52db95b7ba4f73aa7ecef5c0b14cb56d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e35d56712aed9e71ea37874c070812dd7d9d664cbfa287ee434642f8c9beb24ad0b5713ac622be3250153f82252ddde4b747f8f75cb0f3359277b64a77655fed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f3a00a966910480449d3a89ee509208f1e74527d7d563e1dc4aa46886dce9ae2c7904edde877f04936968f27af204b9a399acb77e98cb68c449afa61090ffca"} 09:41:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:41:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:41:08 INFO - Contents: 09:41:08 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d05c2d3ba6958ecd452500ae0f8a4046e9a8b58e472016cea01a17c820699f4de37c2d76c238b32e3260ebf66469dea8dd075fbbf8c57869628f6072e951dcb1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c08ee0fa3b84e4527857b4de6e0521dfeed1bd2226b8c15c427c847333b40f55a310b2b9d4caa5545f5f93d5e1fe60c52db95b7ba4f73aa7ecef5c0b14cb56d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e35d56712aed9e71ea37874c070812dd7d9d664cbfa287ee434642f8c9beb24ad0b5713ac622be3250153f82252ddde4b747f8f75cb0f3359277b64a77655fed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f3a00a966910480449d3a89ee509208f1e74527d7d563e1dc4aa46886dce9ae2c7904edde877f04936968f27af204b9a399acb77e98cb68c449afa61090ffca"} 09:41:08 INFO - Running post-run listener: copy_logs_to_upload_dir 09:41:08 INFO - Copying logs to upload dir... 09:41:08 INFO - mkdir: /builds/slave/test/build/upload/logs 09:41:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1319.845573 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2017-06-14 09:41:08.365616) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-14 09:41:08.369571) ========= 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=a0d2d2de893abaa8702a9954000001a7-1497448790.253951-1184151064 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/d05c2d3ba6958ecd452500ae0f8a4046e9a8b58e472016cea01a17c820699f4de37c2d76c238b32e3260ebf66469dea8dd075fbbf8c57869628f6072e951dcb1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c08ee0fa3b84e4527857b4de6e0521dfeed1bd2226b8c15c427c847333b40f55a310b2b9d4caa5545f5f93d5e1fe60c52db95b7ba4f73aa7ecef5c0b14cb56d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e35d56712aed9e71ea37874c070812dd7d9d664cbfa287ee434642f8c9beb24ad0b5713ac622be3250153f82252ddde4b747f8f75cb0f3359277b64a77655fed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f3a00a966910480449d3a89ee509208f1e74527d7d563e1dc4aa46886dce9ae2c7904edde877f04936968f27af204b9a399acb77e98cb68c449afa61090ffca"} build_url:https://queue.taskcluster.net/v1/task/ZCCbD-PoToKOc9-qg9Y1MA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011322 build_url: 'https://queue.taskcluster.net/v1/task/ZCCbD-PoToKOc9-qg9Y1MA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d05c2d3ba6958ecd452500ae0f8a4046e9a8b58e472016cea01a17c820699f4de37c2d76c238b32e3260ebf66469dea8dd075fbbf8c57869628f6072e951dcb1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c08ee0fa3b84e4527857b4de6e0521dfeed1bd2226b8c15c427c847333b40f55a310b2b9d4caa5545f5f93d5e1fe60c52db95b7ba4f73aa7ecef5c0b14cb56d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e35d56712aed9e71ea37874c070812dd7d9d664cbfa287ee434642f8c9beb24ad0b5713ac622be3250153f82252ddde4b747f8f75cb0f3359277b64a77655fed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f3a00a966910480449d3a89ee509208f1e74527d7d563e1dc4aa46886dce9ae2c7904edde877f04936968f27af204b9a399acb77e98cb68c449afa61090ffca"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-14 09:41:08.394788) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-14 09:41:08.395120) ========= 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=a0d2d2de893abaa8702a9954000001a7-1497448790.253951-1184151064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-14 09:41:08.480788) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-14 09:41:08.481103) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-14 09:41:08.481426) ========= ========= Total master_lag: 0.22 =========