builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-020 starttime: 1499476047.87 results: success (0) revision: 06c1a0dc0fd8719ffa2d9aa2de75f32de5657102 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-07 18:07:27.869694) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-07 18:07:27.870363) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-07 18:07:27.870672) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-07 18:07:27.896443) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-07 18:07:27.896878) ========= 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=af724c981e2a0f424dbabf99000001e7-1499461178.923793-336966328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-07 18:07:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 77.6K=0.2s 2017-07-07 18:07:28 (77.6 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.272878 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-07 18:07:28.197781) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-07 18:07:28.198072) ========= 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=af724c981e2a0f424dbabf99000001e7-1499461178.923793-336966328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017302 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-07 18:07:28.266701) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-07 18:07:28.267006) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 06c1a0dc0fd8719ffa2d9aa2de75f32de5657102 --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 06c1a0dc0fd8719ffa2d9aa2de75f32de5657102 --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=af724c981e2a0f424dbabf99000001e7-1499461178.923793-336966328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-07 18:07:28,735 truncating revision to first 12 chars 2017-07-07 18:07:28,735 Setting DEBUG logging. 2017-07-07 18:07:28,736 attempt 1/10 2017-07-07 18:07:28,736 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/06c1a0dc0fd8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-07 18:07:29,192 unpacking tar archive at: mozilla-central-06c1a0dc0fd8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.865916 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-07 18:07:29.152377) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-07 18:07:29.152693) ========= script_repo_revision: 06c1a0dc0fd8719ffa2d9aa2de75f32de5657102 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-07 18:07:29.153061) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-07 18:07:29.153333) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-07 18:07:29.164157) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-07-07 18:07:29.164422) ========= /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=af724c981e2a0f424dbabf99000001e7-1499461178.923793-336966328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:07:29 INFO - MultiFileLogger online at 20170707 18:07:29 in /builds/slave/test 18:07:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:07:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:07:29 INFO - {'append_to_log': False, 18:07:29 INFO - 'base_work_dir': '/builds/slave/test', 18:07:29 INFO - 'blob_upload_branch': 'Firefox', 18:07:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:07:29 INFO - 'branch': 'Firefox', 18:07:29 INFO - 'buildbot_json_path': 'buildprops.json', 18:07:29 INFO - 'code_coverage': False, 18:07:29 INFO - 'config_files': ('talos/linux_config.py',), 18:07:29 INFO - 'default_actions': ('clobber', 18:07:29 INFO - 'read-buildbot-config', 18:07:29 INFO - 'download-and-extract', 18:07:29 INFO - 'populate-webroot', 18:07:29 INFO - 'create-virtualenv', 18:07:29 INFO - 'install', 18:07:29 INFO - 'setup-mitmproxy', 18:07:29 INFO - 'run-tests'), 18:07:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:07:29 INFO - 'disable_ccov_upload': False, 18:07:29 INFO - 'download_minidump_stackwalk': True, 18:07:29 INFO - 'download_symbols': 'ondemand', 18:07:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:07:29 INFO - 'tooltool.py': '/tools/tooltool.py', 18:07:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:07:29 INFO - '/tools/misc-python/virtualenv.py')}, 18:07:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:07:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:07:29 INFO - 'gecko_profile': False, 18:07:29 INFO - 'gecko_profile_interval': 0, 18:07:29 INFO - 'installer_path': 'installer.exe', 18:07:29 INFO - 'log_level': 'info', 18:07:29 INFO - 'log_name': 'talos', 18:07:29 INFO - 'log_to_console': True, 18:07:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:07:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:07:29 INFO - 'opt_config_files': (), 18:07:29 INFO - 'pip_index': False, 18:07:29 INFO - 'suite': 'dromaeojs-e10s', 18:07:29 INFO - 'system_bits': '32', 18:07:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:07:29 INFO - 'title': 'talos-linux64-ix-020', 18:07:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:07:29 INFO - 'use_talos_json': True, 18:07:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:07:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:07:29 INFO - 'work_dir': 'build'} 18:07:29 INFO - [mozharness: 2017-07-08 01:07:29.735754Z] Running clobber step. 18:07:29 INFO - Running pre-action listener: _resource_record_pre_action 18:07:29 INFO - Running main action method: clobber 18:07:29 INFO - rmtree: /builds/slave/test/build 18:07:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:07:30 INFO - Running post-action listener: _resource_record_post_action 18:07:30 INFO - [mozharness: 2017-07-08 01:07:30.771095Z] Finished clobber step (success) 18:07:30 INFO - [mozharness: 2017-07-08 01:07:30.771198Z] Running read-buildbot-config step. 18:07:30 INFO - Running pre-action listener: _resource_record_pre_action 18:07:30 INFO - Running main action method: read_buildbot_config 18:07:30 INFO - Using buildbot properties: 18:07:30 INFO - { 18:07:30 INFO - "project": "", 18:07:30 INFO - "product": "firefox", 18:07:30 INFO - "who": "kwierso@gmail.com", 18:07:30 INFO - "installer_path": "public/build/target.tar.bz2", 18:07:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 18:07:30 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 18:07:30 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 18:07:30 INFO - "stage_platform": "linux64-stylosequential", 18:07:30 INFO - "basedir": "/builds/slave/test", 18:07:30 INFO - "buildnumber": 108, 18:07:30 INFO - "platform": "ubuntu64_hw_styloseq", 18:07:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:07:30 INFO - "slavebuilddir": "test", 18:07:30 INFO - "taskId": "D428XbN_Roe91z6pCGzkxg", 18:07:30 INFO - "branch": "mozilla-central", 18:07:30 INFO - "script_repo_revision": "production", 18:07:30 INFO - "revision": "06c1a0dc0fd8719ffa2d9aa2de75f32de5657102", 18:07:30 INFO - "slavename": "talos-linux64-ix-020", 18:07:30 INFO - "repo_path": "mozilla-central" 18:07:30 INFO - } 18:07:30 INFO - Finding installer, test and symbols from parent task. 18:07:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D428XbN_Roe91z6pCGzkxg'}, attempt #1 18:07:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D428XbN_Roe91z6pCGzkxg'}, attempt #1 18:07:31 INFO - Task dependencies: D2rRP0iaRl-gLAoDs4K12Q 18:07:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D2rRP0iaRl-gLAoDs4K12Q'}, attempt #1 18:07:32 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/D2rRP0iaRl-gLAoDs4K12Q/artifacts/public/build/target.tar.bz2 18:07:32 INFO - Set test_url: https://queue.taskcluster.net/v1/task/D2rRP0iaRl-gLAoDs4K12Q/artifacts/public/build/test_packages.json 18:07:32 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/D2rRP0iaRl-gLAoDs4K12Q/artifacts/public/build/target.crashreporter-symbols.zip 18:07:32 INFO - Running post-action listener: _resource_record_post_action 18:07:32 INFO - [mozharness: 2017-07-08 01:07:32.127710Z] Finished read-buildbot-config step (success) 18:07:32 INFO - [mozharness: 2017-07-08 01:07:32.127931Z] Running download-and-extract step. 18:07:32 INFO - Running pre-action listener: _resource_record_pre_action 18:07:32 INFO - Running main action method: download_and_extract 18:07:32 INFO - mkdir: /builds/slave/test/build/tests 18:07:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:07:32 INFO - trying https://queue.taskcluster.net/v1/task/D2rRP0iaRl-gLAoDs4K12Q/artifacts/public/build/target.test_packages.json 18:07:32 INFO - Downloading https://queue.taskcluster.net/v1/task/D2rRP0iaRl-gLAoDs4K12Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:07:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D2rRP0iaRl-gLAoDs4K12Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:07:32 INFO - Downloaded 989 bytes. 18:07:32 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:07:32 INFO - Using the following test package requirements: 18:07:32 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:07:32 INFO - u'common': [u'target.common.tests.zip'], 18:07:32 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:07:32 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:07:32 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:07:32 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:07:32 INFO - u'mozbase': [u'target.common.tests.zip'], 18:07:32 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:07:32 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:07:32 INFO - u'web-platform': [u'target.common.tests.zip', 18:07:32 INFO - u'target.web-platform.tests.tar.gz'], 18:07:32 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:07:32 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:07:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D2rRP0iaRl-gLAoDs4K12Q/artifacts/public/build/target.common.tests.zip 18:07:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D2rRP0iaRl-gLAoDs4K12Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:07:32 INFO - Fetch https://queue.taskcluster.net/v1/task/D2rRP0iaRl-gLAoDs4K12Q/artifacts/public/build/target.common.tests.zip into memory 18:07:36 INFO - Content-Length response header: 67424115 18:07:36 INFO - Bytes received: 67424115 18:07:47 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:07:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D2rRP0iaRl-gLAoDs4K12Q/artifacts/public/build/target.common.tests.zip 18:07:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D2rRP0iaRl-gLAoDs4K12Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:07:47 INFO - Fetch https://queue.taskcluster.net/v1/task/D2rRP0iaRl-gLAoDs4K12Q/artifacts/public/build/target.common.tests.zip into memory 18:07:50 INFO - Content-Length response header: 67424115 18:07:50 INFO - Bytes received: 67424115 18:08:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D2rRP0iaRl-gLAoDs4K12Q/artifacts/public/build/target.talos.tests.zip 18:08:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D2rRP0iaRl-gLAoDs4K12Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:08:02 INFO - Fetch https://queue.taskcluster.net/v1/task/D2rRP0iaRl-gLAoDs4K12Q/artifacts/public/build/target.talos.tests.zip into memory 18:08:02 INFO - Content-Length response header: 14472079 18:08:02 INFO - Bytes received: 14472079 18:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:03 INFO - trying https://queue.taskcluster.net/v1/task/D2rRP0iaRl-gLAoDs4K12Q/artifacts/public/build/target.tar.bz2 18:08:03 INFO - Downloading https://queue.taskcluster.net/v1/task/D2rRP0iaRl-gLAoDs4K12Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:08:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D2rRP0iaRl-gLAoDs4K12Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:08:05 INFO - Downloaded 61967020 bytes. 18:08:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D2rRP0iaRl-gLAoDs4K12Q/artifacts/public/build/target.tar.bz2 18:08:05 INFO - mkdir: /builds/slave/test/properties 18:08:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:08:05 INFO - Writing to file /builds/slave/test/properties/build_url 18:08:05 INFO - Contents: 18:08:05 INFO - build_url:https://queue.taskcluster.net/v1/task/D2rRP0iaRl-gLAoDs4K12Q/artifacts/public/build/target.tar.bz2 18:08:05 INFO - Running post-action listener: _resource_record_post_action 18:08:05 INFO - Running post-action listener: set_extra_try_arguments 18:08:05 INFO - [mozharness: 2017-07-08 01:08:05.760289Z] Finished download-and-extract step (success) 18:08:05 INFO - [mozharness: 2017-07-08 01:08:05.760519Z] Running populate-webroot step. 18:08:05 INFO - Running pre-action listener: _resource_record_pre_action 18:08:05 INFO - Running main action method: populate_webroot 18:08:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:08:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:08:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:08:05 INFO - '--tppagecycles', 18:08:05 INFO - '7'], 18:08:05 INFO - 'tests': ['tsvgm']}}, 18:08:05 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:08:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:08:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:08:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:08:05 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:08:05 INFO - 'talos_options': ['--disable-e10s'], 18:08:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:08:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:08:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:08:05 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:08:05 INFO - 'talos_options': ['--disable-e10s'], 18:08:05 INFO - 'tests': ['damp', 'tps']}, 18:08:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:08:05 INFO - 'tests': ['damp', 'tps']}, 18:08:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:08:05 INFO - 'tests': ['dromaeo_dom']}, 18:08:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:08:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:08:05 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 18:08:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:08:05 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:08:05 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:08:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:08:05 INFO - 'tests': ['a11yr', 18:08:05 INFO - 'ts_paint', 18:08:05 INFO - 'tpaint', 18:08:05 INFO - 'sessionrestore', 18:08:05 INFO - 'sessionrestore_no_auto_restore', 18:08:05 INFO - 'tabpaint']}, 18:08:05 INFO - 'other-e10s': {'tests': ['a11yr', 18:08:05 INFO - 'ts_paint', 18:08:05 INFO - 'tpaint', 18:08:05 INFO - 'sessionrestore', 18:08:05 INFO - 'sessionrestore_many_windows', 18:08:05 INFO - 'sessionrestore_no_auto_restore', 18:08:05 INFO - 'tabpaint']}, 18:08:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:08:05 INFO - 'ts_paint', 18:08:05 INFO - 'tpaint', 18:08:05 INFO - 'sessionrestore', 18:08:05 INFO - 'sessionrestore_many_windows', 18:08:05 INFO - 'sessionrestore_no_auto_restore', 18:08:05 INFO - 'tabpaint']}, 18:08:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:08:05 INFO - 'ts_paint', 18:08:05 INFO - 'tpaint', 18:08:05 INFO - 'sessionrestore', 18:08:05 INFO - 'sessionrestore_many_windows', 18:08:05 INFO - 'sessionrestore_no_auto_restore', 18:08:05 INFO - 'tabpaint']}, 18:08:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:08:05 INFO - 'tests': ['a11yr', 18:08:05 INFO - 'ts_paint', 18:08:05 INFO - 'tpaint', 18:08:05 INFO - 'sessionrestore', 18:08:05 INFO - 'sessionrestore_no_auto_restore', 18:08:05 INFO - 'tabpaint']}, 18:08:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:08:05 INFO - 'tests': ['a11yr', 18:08:05 INFO - 'ts_paint', 18:08:05 INFO - 'tpaint', 18:08:05 INFO - 'sessionrestore', 18:08:05 INFO - 'sessionrestore_no_auto_restore', 18:08:05 INFO - 'tabpaint']}, 18:08:05 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 18:08:05 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:08:05 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:08:05 INFO - 'talos_options': ['--mitmproxy', 18:08:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:08:05 INFO - '--firstNonBlankPaint'], 18:08:05 INFO - 'tests': ['quantum_pageload_google', 18:08:05 INFO - 'quantum_pageload_youtube', 18:08:05 INFO - 'quantum_pageload_amazon', 18:08:05 INFO - 'quantum_pageload_facebook']}, 18:08:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:08:05 INFO - 'tests': ['tsvgx', 18:08:05 INFO - 'tsvgr_opacity', 18:08:05 INFO - 'tart', 18:08:05 INFO - 'tscrollx', 18:08:05 INFO - 'cart', 18:08:05 INFO - 'tsvg_static']}, 18:08:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:08:05 INFO - 'tsvgr_opacity', 18:08:05 INFO - 'tart', 18:08:05 INFO - 'tscrollx', 18:08:05 INFO - 'cart', 18:08:05 INFO - 'tsvg_static']}, 18:08:05 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:08:05 INFO - 'talos_options': ['--disable-e10s'], 18:08:05 INFO - 'tests': ['tp5o']}, 18:08:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:08:05 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:08:05 INFO - 'talos_options': ['--disable-e10s', 18:08:05 INFO - '--xperf_path', 18:08:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:08:05 INFO - 'tests': ['tp5n']}, 18:08:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:08:05 INFO - 'talos_options': ['--xperf_path', 18:08:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:08:05 INFO - 'tests': ['tp5n']}}, 18:08:05 INFO - 'talos.zip': {'path': '', 18:08:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:08:05 INFO - Running post-action listener: _resource_record_post_action 18:08:05 INFO - [mozharness: 2017-07-08 01:08:05.781962Z] Finished populate-webroot step (success) 18:08:05 INFO - [mozharness: 2017-07-08 01:08:05.782053Z] Running create-virtualenv step. 18:08:05 INFO - Running pre-action listener: _resource_record_pre_action 18:08:05 INFO - Running main action method: create_virtualenv 18:08:05 INFO - Creating virtualenv /builds/slave/test/build/venv 18:08:05 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:08:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:08:05 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:08:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:08:05 INFO - Using real prefix '/usr' 18:08:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:08:06 INFO - Installing distribute.............................................................................................................................................................................................done. 18:08:08 INFO - Installing pip.................done. 18:08:08 INFO - Return code: 0 18:08:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:08:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:08:08 INFO - Reading from file tmpfile_stdout 18:08:08 INFO - Output received: 18:08:08 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:08:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:08:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b0fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b42a0>, '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 0x22b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22af4d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1499461178.923793-336966328', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:08:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:08:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:08:08 INFO - Using env: {'DISPLAY': ':0', 18:08:08 INFO - 'HOME': '/home/cltbld', 18:08:08 INFO - 'LANG': 'en_US.UTF-8', 18:08:08 INFO - 'LANGUAGE': 'en_US:en', 18:08:08 INFO - 'LOGNAME': 'cltbld', 18:08:08 INFO - 'MAIL': '/var/mail/cltbld', 18:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:08:08 INFO - 'MOZ_NO_REMOTE': '1', 18:08:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:08:08 INFO - 'NO_EM_RESTART': '1', 18:08:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:08:08 INFO - 'PWD': '/builds/slave/test', 18:08:08 INFO - 'SHELL': '/bin/bash', 18:08:08 INFO - 'SHLVL': '1', 18:08:08 INFO - 'TERM': 'linux', 18:08:08 INFO - 'TMOUT': '86400', 18:08:08 INFO - 'USER': 'cltbld', 18:08:08 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1499461178.923793-336966328', 18:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:08:08 INFO - '_': '/tools/buildbot/bin/python'} 18:08:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:08:09 INFO - Cleaning up... 18:08:09 INFO - Return code: 0 18:08:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:08:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:08:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:08:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b0fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b42a0>, '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 0x22b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22af4d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1499461178.923793-336966328', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:08:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:08:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:08:09 INFO - Using env: {'DISPLAY': ':0', 18:08:09 INFO - 'HOME': '/home/cltbld', 18:08:09 INFO - 'LANG': 'en_US.UTF-8', 18:08:09 INFO - 'LANGUAGE': 'en_US:en', 18:08:09 INFO - 'LOGNAME': 'cltbld', 18:08:09 INFO - 'MAIL': '/var/mail/cltbld', 18:08:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:08:09 INFO - 'MOZ_NO_REMOTE': '1', 18:08:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:08:09 INFO - 'NO_EM_RESTART': '1', 18:08:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:08:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:08:09 INFO - 'PWD': '/builds/slave/test', 18:08:09 INFO - 'SHELL': '/bin/bash', 18:08:09 INFO - 'SHLVL': '1', 18:08:09 INFO - 'TERM': 'linux', 18:08:09 INFO - 'TMOUT': '86400', 18:08:09 INFO - 'USER': 'cltbld', 18:08:09 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1499461178.923793-336966328', 18:08:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:08:09 INFO - '_': '/tools/buildbot/bin/python'} 18:08:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:08:09 INFO - Downloading/unpacking psutil>=3.1.1 18:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:08:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:08:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:08:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:08:10 INFO - Installing collected packages: psutil 18:08:10 INFO - Running setup.py install for psutil 18:08:10 INFO - building 'psutil._psutil_linux' extension 18:08:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:08:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:08:10 INFO - building 'psutil._psutil_posix' extension 18:08:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:08:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:08:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:08:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:08:10 INFO - Successfully installed psutil 18:08:10 INFO - Cleaning up... 18:08:11 INFO - Return code: 0 18:08:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:08:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:08:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:08:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b0fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b42a0>, '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 0x22b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22af4d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1499461178.923793-336966328', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:08:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:08:11 INFO - Using env: {'DISPLAY': ':0', 18:08:11 INFO - 'HOME': '/home/cltbld', 18:08:11 INFO - 'LANG': 'en_US.UTF-8', 18:08:11 INFO - 'LANGUAGE': 'en_US:en', 18:08:11 INFO - 'LOGNAME': 'cltbld', 18:08:11 INFO - 'MAIL': '/var/mail/cltbld', 18:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:08:11 INFO - 'MOZ_NO_REMOTE': '1', 18:08:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:08:11 INFO - 'NO_EM_RESTART': '1', 18:08:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:08:11 INFO - 'PWD': '/builds/slave/test', 18:08:11 INFO - 'SHELL': '/bin/bash', 18:08:11 INFO - 'SHLVL': '1', 18:08:11 INFO - 'TERM': 'linux', 18:08:11 INFO - 'TMOUT': '86400', 18:08:11 INFO - 'USER': 'cltbld', 18:08:11 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1499461178.923793-336966328', 18:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:08:11 INFO - '_': '/tools/buildbot/bin/python'} 18:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:08:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:08:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:08:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:08:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:08:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:08:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:08:12 INFO - Installing collected packages: mozsystemmonitor 18:08:12 INFO - Running setup.py install for mozsystemmonitor 18:08:12 INFO - Successfully installed mozsystemmonitor 18:08:12 INFO - Cleaning up... 18:08:12 INFO - Return code: 0 18:08:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:08:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:08:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:08:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b0fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b42a0>, '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 0x22b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22af4d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1499461178.923793-336966328', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:08:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:08:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:08:12 INFO - Using env: {'DISPLAY': ':0', 18:08:12 INFO - 'HOME': '/home/cltbld', 18:08:12 INFO - 'LANG': 'en_US.UTF-8', 18:08:12 INFO - 'LANGUAGE': 'en_US:en', 18:08:12 INFO - 'LOGNAME': 'cltbld', 18:08:12 INFO - 'MAIL': '/var/mail/cltbld', 18:08:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:08:12 INFO - 'MOZ_NO_REMOTE': '1', 18:08:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:08:12 INFO - 'NO_EM_RESTART': '1', 18:08:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:08:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:08:12 INFO - 'PWD': '/builds/slave/test', 18:08:12 INFO - 'SHELL': '/bin/bash', 18:08:12 INFO - 'SHLVL': '1', 18:08:12 INFO - 'TERM': 'linux', 18:08:12 INFO - 'TMOUT': '86400', 18:08:12 INFO - 'USER': 'cltbld', 18:08:12 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1499461178.923793-336966328', 18:08:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:08:12 INFO - '_': '/tools/buildbot/bin/python'} 18:08:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:08:12 INFO - Downloading/unpacking jsonschema==2.5.1 18:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:08:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:08:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:08:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:08:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:08:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:08:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:08:13 INFO - Downloading functools32-3.2.3-2.tar.gz 18:08:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:08:13 INFO - warning: no files found matching '*.txt' 18:08:13 INFO - no previously-included directories found matching 'build' 18:08:13 INFO - no previously-included directories found matching 'dist' 18:08:13 INFO - no previously-included directories found matching '.git*' 18:08:13 INFO - Installing collected packages: jsonschema, functools32 18:08:14 INFO - Running setup.py install for functools32 18:08:14 INFO - warning: no files found matching '*.txt' 18:08:14 INFO - no previously-included directories found matching 'build' 18:08:14 INFO - no previously-included directories found matching 'dist' 18:08:14 INFO - no previously-included directories found matching '.git*' 18:08:14 INFO - Successfully installed jsonschema functools32 18:08:14 INFO - Cleaning up... 18:08:14 INFO - Return code: 0 18:08:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:08:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:08:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:08:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b0fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b42a0>, '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 0x22b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22af4d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1499461178.923793-336966328', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:08:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:08:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:08:14 INFO - Using env: {'DISPLAY': ':0', 18:08:14 INFO - 'HOME': '/home/cltbld', 18:08:14 INFO - 'LANG': 'en_US.UTF-8', 18:08:14 INFO - 'LANGUAGE': 'en_US:en', 18:08:14 INFO - 'LOGNAME': 'cltbld', 18:08:14 INFO - 'MAIL': '/var/mail/cltbld', 18:08:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:08:14 INFO - 'MOZ_NO_REMOTE': '1', 18:08:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:08:14 INFO - 'NO_EM_RESTART': '1', 18:08:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:08:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:08:14 INFO - 'PWD': '/builds/slave/test', 18:08:14 INFO - 'SHELL': '/bin/bash', 18:08:14 INFO - 'SHLVL': '1', 18:08:14 INFO - 'TERM': 'linux', 18:08:14 INFO - 'TMOUT': '86400', 18:08:14 INFO - 'USER': 'cltbld', 18:08:14 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1499461178.923793-336966328', 18:08:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:08:14 INFO - '_': '/tools/buildbot/bin/python'} 18:08:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:08:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:08:14 INFO - Cleaning up... 18:08:14 INFO - Return code: 0 18:08:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:08:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:08:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:08:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b0fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b42a0>, '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 0x22b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22af4d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1499461178.923793-336966328', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:08:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:08:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:08:14 INFO - Using env: {'DISPLAY': ':0', 18:08:14 INFO - 'HOME': '/home/cltbld', 18:08:14 INFO - 'LANG': 'en_US.UTF-8', 18:08:14 INFO - 'LANGUAGE': 'en_US:en', 18:08:14 INFO - 'LOGNAME': 'cltbld', 18:08:14 INFO - 'MAIL': '/var/mail/cltbld', 18:08:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:08:14 INFO - 'MOZ_NO_REMOTE': '1', 18:08:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:08:14 INFO - 'NO_EM_RESTART': '1', 18:08:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:08:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:08:14 INFO - 'PWD': '/builds/slave/test', 18:08:14 INFO - 'SHELL': '/bin/bash', 18:08:14 INFO - 'SHLVL': '1', 18:08:14 INFO - 'TERM': 'linux', 18:08:14 INFO - 'TMOUT': '86400', 18:08:14 INFO - 'USER': 'cltbld', 18:08:14 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1499461178.923793-336966328', 18:08:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:08:14 INFO - '_': '/tools/buildbot/bin/python'} 18:08:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:08:14 INFO - Downloading/unpacking blobuploader==1.2.4 18:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:08:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:08:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:08:15 INFO - Downloading blobuploader-1.2.4.tar.gz 18:08:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:08:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:08:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:08:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:08:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:08:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:08:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:08:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:08:16 INFO - Downloading docopt-0.6.1.tar.gz 18:08:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:08:16 INFO - Installing collected packages: blobuploader, requests, docopt 18:08:16 INFO - Running setup.py install for blobuploader 18:08:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:08:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:08:16 INFO - Running setup.py install for requests 18:08:16 INFO - Running setup.py install for docopt 18:08:16 INFO - Successfully installed blobuploader requests docopt 18:08:16 INFO - Cleaning up... 18:08:16 INFO - Return code: 0 18:08:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:08:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:08:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:08:16 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 0x1f411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b0fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b42a0>, '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 0x22b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22af4d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1499461178.923793-336966328', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:08:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:08:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:08:16 INFO - Using env: {'DISPLAY': ':0', 18:08:16 INFO - 'HOME': '/home/cltbld', 18:08:16 INFO - 'LANG': 'en_US.UTF-8', 18:08:16 INFO - 'LANGUAGE': 'en_US:en', 18:08:16 INFO - 'LOGNAME': 'cltbld', 18:08:16 INFO - 'MAIL': '/var/mail/cltbld', 18:08:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:08:16 INFO - 'MOZ_NO_REMOTE': '1', 18:08:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:08:16 INFO - 'NO_EM_RESTART': '1', 18:08:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:08:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:08:16 INFO - 'PWD': '/builds/slave/test', 18:08:16 INFO - 'SHELL': '/bin/bash', 18:08:16 INFO - 'SHLVL': '1', 18:08:16 INFO - 'TERM': 'linux', 18:08:16 INFO - 'TMOUT': '86400', 18:08:16 INFO - 'USER': 'cltbld', 18:08:16 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1499461178.923793-336966328', 18:08:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:08:16 INFO - '_': '/tools/buildbot/bin/python'} 18:08:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:08:17 INFO - Running setup.py (path:/tmp/pip-sCY72_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:08:17 INFO - Running setup.py (path:/tmp/pip-xY8TUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:08:17 INFO - Running setup.py (path:/tmp/pip-LsYWZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:08:17 INFO - Running setup.py (path:/tmp/pip-F3eAdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:08:17 INFO - Running setup.py (path:/tmp/pip-YfsZLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:08:17 INFO - Running setup.py (path:/tmp/pip-5242Gr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:08:17 INFO - Running setup.py (path:/tmp/pip-T7I1d4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:08:17 INFO - Running setup.py (path:/tmp/pip-ikQyt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:08:17 INFO - Running setup.py (path:/tmp/pip-5xgvg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:08:17 INFO - Running setup.py (path:/tmp/pip-aVpc3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:08:17 INFO - Running setup.py (path:/tmp/pip-SFj_CW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:08:17 INFO - Running setup.py (path:/tmp/pip-c09_5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:08:17 INFO - Running setup.py (path:/tmp/pip-R_Ai6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:08:18 INFO - Running setup.py (path:/tmp/pip-n5PNRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:08:18 INFO - Running setup.py (path:/tmp/pip-DLNKKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:08:18 INFO - Running setup.py (path:/tmp/pip-2Bt_k3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:08:18 INFO - Running setup.py (path:/tmp/pip-03GCyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:08:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:08:18 INFO - Running setup.py install for manifestparser 18:08:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:08:18 INFO - Running setup.py install for mozcrash 18:08:18 INFO - Running setup.py install for mozdebug 18:08:18 INFO - Running setup.py install for mozdevice 18:08:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:08:18 INFO - Running setup.py install for mozfile 18:08:18 INFO - Running setup.py install for mozhttpd 18:08:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:08:18 INFO - Running setup.py install for mozinfo 18:08:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:08:19 INFO - Running setup.py install for mozInstall 18:08:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:08:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:08:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:08:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:08:19 INFO - Running setup.py install for mozleak 18:08:19 INFO - Running setup.py install for mozlog 18:08:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:08:19 INFO - Running setup.py install for moznetwork 18:08:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:08:19 INFO - Running setup.py install for mozprocess 18:08:19 INFO - Running setup.py install for mozprofile 18:08:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:08:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:08:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:08:19 INFO - Running setup.py install for mozrunner 18:08:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:08:19 INFO - Running setup.py install for mozscreenshot 18:08:19 INFO - Running setup.py install for moztest 18:08:19 INFO - Running setup.py install for mozversion 18:08:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:08:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:08:20 INFO - Cleaning up... 18:08:20 INFO - Return code: 0 18:08:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:08:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:08:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:08:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b0fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b42a0>, '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 0x22b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22af4d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1499461178.923793-336966328', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:08:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:08:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:08:20 INFO - Using env: {'DISPLAY': ':0', 18:08:20 INFO - 'HOME': '/home/cltbld', 18:08:20 INFO - 'LANG': 'en_US.UTF-8', 18:08:20 INFO - 'LANGUAGE': 'en_US:en', 18:08:20 INFO - 'LOGNAME': 'cltbld', 18:08:20 INFO - 'MAIL': '/var/mail/cltbld', 18:08:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:08:20 INFO - 'MOZ_NO_REMOTE': '1', 18:08:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:08:20 INFO - 'NO_EM_RESTART': '1', 18:08:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:08:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:08:20 INFO - 'PWD': '/builds/slave/test', 18:08:20 INFO - 'SHELL': '/bin/bash', 18:08:20 INFO - 'SHLVL': '1', 18:08:20 INFO - 'TERM': 'linux', 18:08:20 INFO - 'TMOUT': '86400', 18:08:20 INFO - 'USER': 'cltbld', 18:08:20 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1499461178.923793-336966328', 18:08:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:08:20 INFO - '_': '/tools/buildbot/bin/python'} 18:08:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:08:20 INFO - Running setup.py (path:/tmp/pip-7OU6q0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:08:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:08:20 INFO - Running setup.py (path:/tmp/pip-YZGxrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:08:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:08:20 INFO - Running setup.py (path:/tmp/pip-Zw4MJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:08:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:08:20 INFO - Running setup.py (path:/tmp/pip-6kkHAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:08:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:08:20 INFO - Running setup.py (path:/tmp/pip-YiWp9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:08:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:08:20 INFO - Running setup.py (path:/tmp/pip-UAom2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:08:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:08:20 INFO - Running setup.py (path:/tmp/pip-atAtXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:08:20 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)) 18:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:08:20 INFO - Running setup.py (path:/tmp/pip-pUgvuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:08:20 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)) 18:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:08:20 INFO - Running setup.py (path:/tmp/pip-XPWdQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:08:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:08:20 INFO - Running setup.py (path:/tmp/pip-XcAlUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:08:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:08:21 INFO - Running setup.py (path:/tmp/pip-UzJ7JO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:08:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:08:21 INFO - Running setup.py (path:/tmp/pip-hJlTjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:08:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:08:21 INFO - Running setup.py (path:/tmp/pip-jRrME6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:08:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:08:21 INFO - Running setup.py (path:/tmp/pip-eDjT82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:08:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:08:21 INFO - Running setup.py (path:/tmp/pip-Zt5Ywj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:08:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:08:21 INFO - Running setup.py (path:/tmp/pip-ioSa7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:08:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:08:21 INFO - Running setup.py (path:/tmp/pip-Y7erN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:08:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:08:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:08:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:08:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:08:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:08:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:08:21 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)) 18:08:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:08:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:08:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:08:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:08:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:08:22 INFO - Downloading blessings-1.6.tar.gz 18:08:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:08:22 INFO - Installing collected packages: blessings 18:08:22 INFO - Running setup.py install for blessings 18:08:22 INFO - Successfully installed blessings 18:08:22 INFO - Cleaning up... 18:08:22 INFO - Return code: 0 18:08:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:08:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:08:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:08:23 INFO - Reading from file tmpfile_stdout 18:08:23 INFO - Current package versions: 18:08:23 INFO - argparse == 1.2.1 18:08:23 INFO - blessings == 1.6 18:08:23 INFO - blobuploader == 1.2.4 18:08:23 INFO - docopt == 0.6.1 18:08:23 INFO - functools32 == 3.2.3-2 18:08:23 INFO - jsonschema == 2.5.1 18:08:23 INFO - manifestparser == 1.1 18:08:23 INFO - mozInstall == 1.13 18:08:23 INFO - mozcrash == 1.0 18:08:23 INFO - mozdebug == 0.1 18:08:23 INFO - mozdevice == 0.51 18:08:23 INFO - mozfile == 1.2 18:08:23 INFO - mozhttpd == 0.7 18:08:23 INFO - mozinfo == 0.10 18:08:23 INFO - mozleak == 0.1 18:08:23 INFO - mozlog == 3.5 18:08:23 INFO - moznetwork == 0.27 18:08:23 INFO - mozprocess == 0.25 18:08:23 INFO - mozprofile == 0.28 18:08:23 INFO - mozrunner == 6.13 18:08:23 INFO - mozscreenshot == 0.1 18:08:23 INFO - mozsystemmonitor == 0.3 18:08:23 INFO - moztest == 0.8 18:08:23 INFO - mozversion == 1.4 18:08:23 INFO - psutil == 3.1.1 18:08:23 INFO - requests == 1.2.3 18:08:23 INFO - wsgiref == 0.1.2 18:08:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:08:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:08:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:08:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b0fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b42a0>, '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 0x22b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22af4d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1499461178.923793-336966328', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:08:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:08:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:08:23 INFO - Using env: {'DISPLAY': ':0', 18:08:23 INFO - 'HOME': '/home/cltbld', 18:08:23 INFO - 'LANG': 'en_US.UTF-8', 18:08:23 INFO - 'LANGUAGE': 'en_US:en', 18:08:23 INFO - 'LOGNAME': 'cltbld', 18:08:23 INFO - 'MAIL': '/var/mail/cltbld', 18:08:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:08:23 INFO - 'MOZ_NO_REMOTE': '1', 18:08:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:08:23 INFO - 'NO_EM_RESTART': '1', 18:08:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:08:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:08:23 INFO - 'PWD': '/builds/slave/test', 18:08:23 INFO - 'SHELL': '/bin/bash', 18:08:23 INFO - 'SHLVL': '1', 18:08:23 INFO - 'TERM': 'linux', 18:08:23 INFO - 'TMOUT': '86400', 18:08:23 INFO - 'USER': 'cltbld', 18:08:23 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1499461178.923793-336966328', 18:08:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:08:23 INFO - '_': '/tools/buildbot/bin/python'} 18:08:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:08:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:08:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:08:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:08:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:08:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:08:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:08:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:08:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:08:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:08:23 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:08:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:08:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:08:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:08:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:08:24 INFO - Downloading marionette_driver-1.4.0.tar.gz 18:08:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 18:08:24 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 18:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:08:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:08:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:08:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:08:24 INFO - Installing collected packages: marionette-driver, simplejson 18:08:24 INFO - Running setup.py install for marionette-driver 18:08:24 INFO - Running setup.py install for simplejson 18:08:24 INFO - building 'simplejson._speedups' extension 18:08:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 18:08:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 18:08:25 INFO - Successfully installed marionette-driver simplejson 18:08:25 INFO - Cleaning up... 18:08:25 INFO - Return code: 0 18:08:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:08:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b0fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b42a0>, '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 0x22b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22af4d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1499461178.923793-336966328', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:08:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:08:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:08:25 INFO - Using env: {'DISPLAY': ':0', 18:08:25 INFO - 'HOME': '/home/cltbld', 18:08:25 INFO - 'LANG': 'en_US.UTF-8', 18:08:25 INFO - 'LANGUAGE': 'en_US:en', 18:08:25 INFO - 'LOGNAME': 'cltbld', 18:08:25 INFO - 'MAIL': '/var/mail/cltbld', 18:08:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:08:25 INFO - 'MOZ_NO_REMOTE': '1', 18:08:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:08:25 INFO - 'NO_EM_RESTART': '1', 18:08:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:08:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:08:25 INFO - 'PWD': '/builds/slave/test', 18:08:25 INFO - 'SHELL': '/bin/bash', 18:08:25 INFO - 'SHLVL': '1', 18:08:25 INFO - 'TERM': 'linux', 18:08:25 INFO - 'TMOUT': '86400', 18:08:25 INFO - 'USER': 'cltbld', 18:08:25 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1499461178.923793-336966328', 18:08:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:08:25 INFO - '_': '/tools/buildbot/bin/python'} 18:08:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:08:26 INFO - Cleaning up... 18:08:26 INFO - Return code: 0 18:08:26 INFO - Running post-action listener: _resource_record_post_action 18:08:26 INFO - Running post-action listener: _start_resource_monitoring 18:08:26 INFO - Starting resource monitoring. 18:08:26 INFO - [mozharness: 2017-07-08 01:08:26.147991Z] Finished create-virtualenv step (success) 18:08:26 INFO - [mozharness: 2017-07-08 01:08:26.148503Z] Running install step. 18:08:26 INFO - Running pre-action listener: _resource_record_pre_action 18:08:26 INFO - Running main action method: install 18:08:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:08:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:08:26 INFO - Reading from file tmpfile_stdout 18:08:26 INFO - Detecting whether we're running mozinstall >=1.0... 18:08:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:08:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:08:26 INFO - Reading from file tmpfile_stdout 18:08:26 INFO - Output received: 18:08:26 INFO - Usage: mozinstall [options] installer 18:08:26 INFO - Options: 18:08:26 INFO - -h, --help show this help message and exit 18:08:26 INFO - -d DEST, --destination=DEST 18:08:26 INFO - Directory to install application into. [default: 18:08:26 INFO - "/builds/slave/test"] 18:08:26 INFO - --app=APP Application being installed. [default: firefox] 18:08:26 INFO - mkdir: /builds/slave/test/build/application 18:08:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:08:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:08:44 INFO - Reading from file tmpfile_stdout 18:08:44 INFO - Output received: 18:08:44 INFO - /builds/slave/test/build/application/firefox/firefox 18:08:44 INFO - Running post-action listener: _resource_record_post_action 18:08:44 INFO - [mozharness: 2017-07-08 01:08:44.573661Z] Finished install step (success) 18:08:44 INFO - [mozharness: 2017-07-08 01:08:44.574003Z] Running setup-mitmproxy step. 18:08:44 INFO - Running pre-action listener: _resource_record_pre_action 18:08:44 INFO - Running main action method: setup_mitmproxy 18:08:44 INFO - Skipping: mitmproxy is not required 18:08:44 INFO - Running post-action listener: _resource_record_post_action 18:08:44 INFO - [mozharness: 2017-07-08 01:08:44.575747Z] Finished setup-mitmproxy step (success) 18:08:44 INFO - [mozharness: 2017-07-08 01:08:44.576080Z] Running run-tests step. 18:08:44 INFO - Running pre-action listener: _resource_record_pre_action 18:08:44 INFO - Running pre-action listener: _set_gcov_prefix 18:08:44 INFO - Running main action method: run_tests 18:08:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:08:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:08:44 INFO - Python 2.7.3 18:08:44 INFO - Return code: 0 18:08:44 INFO - grabbing minidump binary from tooltool 18:08: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')]} 18:08:44 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 0x22b42a0>, '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 0x22b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22af4d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:08:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:08:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:08:44 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:08:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:08:44 INFO - Return code: 0 18:08:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:08:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:08:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:08:44 INFO - ENV: RUST_BACKTRACE is now 1 18:08:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:08:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:08:44 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/D2rRP0iaRl-gLAoDs4K12Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:08:44 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/D2rRP0iaRl-gLAoDs4K12Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-020 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:08:44 INFO - Using env: {'DISPLAY': ':0', 18:08:44 INFO - 'HOME': '/home/cltbld', 18:08:44 INFO - 'LANG': 'en_US.UTF-8', 18:08:44 INFO - 'LANGUAGE': 'en_US:en', 18:08:44 INFO - 'LOGNAME': 'cltbld', 18:08:44 INFO - 'MAIL': '/var/mail/cltbld', 18:08:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:08:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:08:44 INFO - 'MOZ_NO_REMOTE': '1', 18:08:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:08:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:08:44 INFO - 'NO_EM_RESTART': '1', 18:08:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:08:44 INFO - 'PWD': '/builds/slave/test', 18:08:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:08:44 INFO - 'RUST_BACKTRACE': '1', 18:08:44 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:08:44 INFO - 'SHELL': '/bin/bash', 18:08:44 INFO - 'SHLVL': '1', 18:08:44 INFO - 'TERM': 'linux', 18:08:44 INFO - 'TMOUT': '86400', 18:08:44 INFO - 'USER': 'cltbld', 18:08:44 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1499461178.923793-336966328', 18:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:08:44 INFO - '_': '/tools/buildbot/bin/python'} 18:08:44 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/D2rRP0iaRl-gLAoDs4K12Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:08:44 INFO - mozversion application_buildid: 20170708002209 18:08:44 INFO - mozversion application_changeset: 06c1a0dc0fd8719ffa2d9aa2de75f32de5657102 18:08:44 INFO - mozversion application_display_name: Nightly 18:08:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:08:44 INFO - mozversion application_name: Firefox 18:08:44 INFO - mozversion application_remotingname: firefox 18:08:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:08:44 INFO - mozversion application_vendor: Mozilla 18:08:44 INFO - mozversion application_version: 56.0a1 18:08:44 INFO - mozversion platform_buildid: 20170708002209 18:08:44 INFO - mozversion platform_changeset: 06c1a0dc0fd8719ffa2d9aa2de75f32de5657102 18:08:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:08:44 INFO - mozversion platform_version: 56.0a1 18:08:44 INFO - using testdate: 1499476124 18:08:44 INFO - actual date: 1499476124 18:08:44 INFO - starting webserver on 'localhost:52938' 18:08:44 INFO - SUITE-START | Running 2 tests 18:08:44 INFO - TEST-START | dromaeo_css 18:08:44 INFO - Initialising browser for dromaeo_css test... 18:08:44 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52938/getInfo.html -profile /tmp/tmpaF6PP8/profile 18:08:44 INFO - TEST-INFO | started process 23642 (/builds/slave/test/build/application/firefox/firefox http://localhost:52938/getInfo.html) 18:08:51 INFO - TEST-INFO | 23642: exit 0 18:08:51 INFO - Browser initialized. 18:08:51 INFO - Running cycle 1/1 for dromaeo_css test... 18:08:51 INFO - TEST-INFO | started process 23860 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaF6PP8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:09:03 INFO - PID 23860 | RSS: Main: 173989888 18:09:03 INFO - PID 23860 | 18:12:02 INFO - PID 23860 | Cycle 1(1): loaded http://localhost:52938/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52938/tests/dromaeo/cssquery-ext.html) 18:12:04 INFO - PID 23860 | RSS: Main: 180011008 18:12:04 INFO - PID 23860 | 18:15:06 INFO - PID 23860 | Cycle 1(1): loaded http://localhost:52938/tests/dromaeo/cssquery-ext.html (next: http://localhost:52938/tests/dromaeo/cssquery-jquery.html) 18:15:07 INFO - PID 23860 | RSS: Main: 177172480 18:15:07 INFO - PID 23860 | 18:18:08 INFO - PID 23860 | Cycle 1(1): loaded http://localhost:52938/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52938/tests/dromaeo/cssquery-mootools.html) 18:18:09 INFO - PID 23860 | RSS: Main: 180445184 18:18:09 INFO - PID 23860 | 18:21:11 INFO - PID 23860 | Cycle 1(1): loaded http://localhost:52938/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52938/tests/dromaeo/cssquery-prototype.html) 18:21:11 INFO - PID 23860 | RSS: Main: 179920896 18:21:11 INFO - PID 23860 | 18:24:14 INFO - PID 23860 | Cycle 1(1): loaded http://localhost:52938/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52938/tests/dromaeo/cssquery-yui.html) 18:24:15 INFO - PID 23860 | RSS: Main: 178782208 18:24:15 INFO - PID 23860 | 18:27:17 INFO - PID 23860 | Cycle 1(1): loaded http://localhost:52938/tests/dromaeo/cssquery-yui.html (next: http://localhost:52938/tests/dromaeo/cssquery-dojo.html) 18:27:17 INFO - PID 23860 | RSS: Main: 182128640 18:27:17 INFO - PID 23860 | 18:27:17 INFO - PID 23860 | __start_tp_report 18:27:17 INFO - PID 23860 | _x_x_mozilla_page_load 18:27:17 INFO - PID 23860 | _x_x_mozilla_page_load_details 18:27:17 INFO - PID 23860 | |i|pagename|runs| 18:27:17 INFO - PID 23860 | |0;dojo.html;3061.954070688939;3114.719675229229;3118.672539383365;3145.889893853715;3170.2708377073286;5948.672822994739;5961.672108034057;6001.9699901500435;6056.727447264872;6061.151438798566;5961.552883533742;6047.4859636930805;6095.024796032636;6109.969450152754;6132.264128304599;5553.305836770403;5573.052581061219;5600.131979543177;5601.691906945116;5631.18347839563;5607.495325420711;5631.267935168423;5655.604107712462;5664.320281566218;5674.205611214413;5623.831285061455;5630.268065151525;5636.041872881599;5636.915446268309;5647.943520564803;5607.607467477278;5623.971880140573;5625.578081643893;5634.7182640867795;5635.492805647511;5507.614466987313;5575;5593.580481463866;5623.465770751772;5705.343885453143;6005.069214271794;6043;6070.787522436738;6103.176071230371;6107.992181290082;6361.968190159066;6428.871422571569;6468.611883287018;6520.967395163041;6533.803985880431;6455.709493072823;6493.350664933516;6506;6519.315471875432;6525.804225873231;6068.514518838482;6078.209832721718;6083.574149809515;6155.784547540859;6158.938410615881;6696.497762667819;6721.395074443323;6762.459003279726;6762.492813039042;6772.458203343721;6299.118123462719;6383.936160638427;6395.488360931115;6465.676716164173;6492.902606460907;6465.288818229991;6490.870182596416;6500.967495162588;6505.41451269388;6513.804585862432;6319.6208227506495;6394.392532709385;6406.551541392151;6457.354264573505;6487.2539657939;5321.624294662605;6337.904931426032;6398.840028999312;6435.549511534241;6464.353564643592;5222.947770522323;5228.9477105229225;5289.18017707256;5300.178472336717;5314.973425132927;4485.349624304457;4556.8177272908715;4561.521040290788;4568.314752787042;4570.177368073712;5573.470520300565;5593.328800543961;5627.043402621564;5628.04323265046;5635.915461268084;6503.674816259168;6509.251436084911;6520.054592084216;6523.902141467882;6529.444997175198;5589.916151257735;5593.888122237614;5599.272094627672;5613.578981576398;5616.803411880564;4800.9917056562135;5690.459406356389;5702.116171993348;5734.168545560954;5737.110747834093;6243.562950593415;6248.156498872685;6310.968445157745;6320.747170113144;6327.177466929362;6490.383413575702;6490.643014634241;6542;6575.046618240424;6580.243272023587;6177.2587289525545;6246.875062498815;6254.124422580751;6276.811695649138;6354.4598709108395;6398.104265402941;6399.8080057598345;6418.743250270124;6441.871162576628;6456.6771661415805;5180.7409629519125;6566.540342176002;6579.539432239889;6664.067030615621;6675.03212034262;6272.968635156795;6314.084457753692;6387.712552935036;6411.903821442589;6421.389967953037;6318.6840657965995;6329.6518691470565;6412.1023056771155;6416.294207637063;6422.614643121427;6154.1999540059505;6203.100550420074;6250.218722659668;6253.624782513064;6268.811935641938;6297.811065668037;6329.841753956188;6348.428641422294;6372.904406434;6404.327545607831;6098.878022439438;6120.234970628671;6135;6151.538634602333;6164.845878853064 18:27:17 INFO - PID 23860 | |1;ext.html;819.7786597618643;841.9663213471462;858.2790456016945;876.3033388456176;884.4428010353479;38559.807200964024;40144.598554014454;40294.99262518442;40367.39448908269;40443.797781011126;36111.2777744445;36132.45801312982;36174;36361;36389.81805090971;6770.96614516928;6893.896591551131;6904.3095690431055;6908.101946746916;6926.064981227545;6844.2129155147295;6857.3828355448;6892.241853396123;6911.377975982161;6932.861342773142;6796.354346337115;6833.555818871782;6867.965660171692;6911.619860907648;6921.723131074751;6836.008778727107;6852.280510546396;6855.794326170223;6859.7652422563915;6859.897101543481;6202.96898515509;6233.688315584248;6245.063240513914;6253.030780229072;6253.843653908643;32862.34275314504;33099;33132.6686733132;33177.3364532708;33403.16492087717;3377.375185590649;3421.161815355254;3436.8281585920604;3526.0303416560396;3638;31417.74329026836;31496.055118346485;31511.212219694462;31552.526712099338;31670;4668.696534725266;4833.879153021167;4869.610431165498;4944.505549445063;5006.349174607314;191732;194283;194565.02717486463;194710;195012;45993.5400645996;46407.53592464099;46746.76626616845;46980.5301946983;47066;49322.260166097534;49729.751351243736;49767.25349119766;49775.50224497781;49853.25220121701;16014.359425623077;16031;16197.919010405109;16207.351705931631;16207.432739854048;13561.796573051412;13563.66090847717;13565.86434135646;13617;13701.246431446367;13985.650358741113;14016.789748153786;14281.071730337495;14287.071340362843;14450.277486125651;5726.312842458931;5752.395998420106;5765.827025189251;5801.622894511843;5900.881982360329;1000.9349392289478;1001.5092604623827;1006.5269323417982;1044.9164066874632;1057.5082586597268;22432.21487247971;22527.211547595754;22688.773112268667;23489.060437582306;23780.762192378203;1095.6001059613343;1098.6649072033106;1120.2662256222188;1121.1199208621356;1124.612008856943;11895.226810257305;11924.642260732191;12155.574554890713;12189.573364932185;12354.320512371725;219878;220149;220674;220696;221264;51800.481995179565;52022;52180;52350;52384.47615523796;1452.0561634937164;1463.4073200353873;1495.9700805983819;1504.2253239581405;1505.9504503380742;22079;22182.88908555447;22432.775672243723;22692.319230423112;23158.305250842503;36591.26817463583;36816.63183368132;36887.44668829916;36922.8153859229;36952.26095478021;182336;182915;183969;185078;185684;34718.132046698025;35837.64162358343;36384.454233187054;38471.615283847925;38474.807625961694;46421.1431542748;46954;47259.291110634054;47259.76370118128;48039;33032.64752142425;33393.33213335768;33473.497897531066;33694.326113478084;33761.83119084389;32228.67771322257;33264.66735332616;33328.33343333168;33497.330053398306;33578.83210583931;35583;36517.08707282339;37107.443388348656;37145.442818358286;37147.62852371442;31658.683413165574;32387.67612323941;32604.510932336507;32653;32742.50886236661;23915.043398263875;24040.87979560091;24388.26835194947;24606.507869842146;24746.133885314648 18:27:17 INFO - PID 23860 | |2;jquery.html;554.2434576802666;557.1696975435694;564.6837770848325;577.3908526504539;595.3778301674749;21550.245741399034;22265.44336391591;22281.331560053182;22534.887325563348;22661.43346416336;25810.741892581067;26067.348316292104;26461.603075953826;26480;26706.599401009;6336.873262534747;6547.181602299713;6558.573692709982;6565.507586930976;6576.6711664416825;6123.357047510014;6502.93497065028;6549.148610680605;6566.047923051155;6569.572977756455;6010.27876654802;6297.3387794281625;6319.842003949892;6352.587081839689;6360.491160707133;6354.078658594501;6366.840828979266;6367.363263673618;6386.552941294065;6386.712597933104;5885.293764748215;5930.140129681172;5932.377100404482;5935.703214839241;5949.524038076944;27299.590506142424;28299.71700283012;28390.29024274389;28589.28526786826;28680;1926.3354142820704;1935.1195206181153;1937.3122541497705;1950.775660798998;1964.165229777339;17851.553711157194;18295.451136465927;18308.359207427675;18341.17464714078;18355.632887342177;2265.127925748582;2305.7578954209735;2314.36355002374;2314.4213946513373;2405.2183040511904;125659;126201;128171;128662;129758;13909.58271251864;14445.277736113363;14511.637209069646;14845.92577037108;15030.17334046616;23271.301860944197;23357.76642233556;23367.53264934692;23406.531869362516;23440.413989650395;10199.337043092175;10267.383956962607;10357.171426285879;10459.215558833119;10504.579816807242;9675.177609903238;9729.805403891882;9772.12050915421;9868.407895526148;9940.652077177265;8988.505632190292;9037.881930733885;9055.275577953747;9189.127032931861;9222.262219022463;2622.960655590168;2683.5303821831103;2751.2296556964084;2763.115802943039;2785.5264605017196;943.7923656795494;946.6118891254553;954.8185844689486;997.0926456924309;998.6554638649654;19426.22295108208;19655.50861228452;19969.302609278373;22444.438889027577;24052.87973560121;1034.2088302448633;1047.4814966591434;1055.4406164732704;1063.6596289187385;1070.4005756776075;11014.614488492864;11094.389808560445;11099.5560177592;11191.16066295015;11465.54137834494;477891;493439;494475;498977;512189;111301;113389;114766;114801.4259928695;118142.40928795472;1299.9870001299867;1310.6133690561308;1318.8813006829432;1321.4846209978116;1324.1657755614094;16971.91514042422;17657.735133972743;17713.557161071076;18031.278748849898;18639.161237744604;51063.234051488515;52818.20772688336;53037.20444193418;54090;54329;66265;69994.65002674954;70990.29009710043;71642;71670;12882.935585322013;13012.414441349973;13267.66830829237;13273.469061237442;13310.201387916755;17725.025123618325;18469.261229550666;18684.813151868308;18833.71749423787;18877.90561047186;15774.447894323643;15900.12549309799;15946.840531594535;16004.91997540005;16072;13411.262380569162;13826.239556824472;14385.712285754436;14638.780418293522;14687.853121468648;15298.617534561725;16252.67494650124;16334;16435.753463697816;16446.177691115634;12673.112882098534;12987;13085.738285234433;13200.339983001004;13296.601101966957;15978.760318594997;16064.678706425571;16076.196190190678;16107.919460402623;16205.108719020096 18:27:17 INFO - PID 23860 | |3;mootools.html;1316.5589527508284;1350.243863436475;1368.2611389849483;1372.1629805818454;1381.8341798984122;13119.737605247888;13591.932040339796;13627.318634068306;13629.863701362983;13655.04414690972;12910.548130815423;13513.797293040612;13815.37830797614;14076.57770266891;14135.434582616683;2555.2334299710105;2604.2968398532385;2623.34416395901;2629.7764690001372;2637.841729496227;2554.6423500709916;2598.0646967091834;2601.856897870616;2603.6745406824148;2613.686357637086;2536.112360673768;2561.3212498687863;2578.2136448383235;2593.1701855406277;2595.584706446969;2557.7442255774367;2653.761161495465;2734.8359098454157;2741.643586333784;2741.9040333588428;2605.674290713661;2620.227033025243;2626.776723978464;2627.303764502389;2628.264086055888;13251.801222981663;13474.393652285671;13552.322383880864;13556.525521606696;13589.048766586342;7317.085364329459;7613.200613935568;7624.428167887375;7626.694932202705;7659.042619672541;4787.521247875219;4838.153323168432;5097.5667068299235;5121.820736274212;5133.024725302218;1774.7249176377682;1785.9910700446414;1820.1172431370774;1847.8891266524051;1866.542697039234;21851.125954961783;21885.67171492429;21933;22004.77995220043;22134.33596992077;5856.472917437451;6173.104899789505;6223.253209614784;6327.4938004959495;6343.333949935282;15349.462768803038;15436.228188590525;15437.30532126057;15462.845371546366;15477.303521341342;7376.446766492427;7460.626968651546;7544;7561.735339263099;7583.165851756303;6901.275366086589;6913.170419549686;6969.9303006969285;6993.580385176906;7019.403350715144;4471.1728330259;4640.69835460694;4659.998100408428;4692.835750748707;4728.71627702339;1456.4829485532696;1461.4081297074702;1470.7205630930089;1472.9852701472848;1496.760518317064;870.4037734152126;876.8860048193694;904.9728508144766;909.3679892474667;923.8198551282435;6917.584944903322;7079.2920707929825;7117.181524124792;7127.002219689248;7145.1068616422945;715.4312321704153;731.184729027131;731.1883808972037;737.7049180327912;745.7091734223549;4179.874603761892;4636.513166117509;4739.881502962385;4770.618350532019;5111.309973153651;17201.7419738704;17876.55308617295;17919.910400447916;17931;17974.640507189783;17191.656166876593;17440.912795435943;17771.644567108844;18722.625547488973;18747.625047499245;10431.634892778717;10882.945585272022;10895.782084358269;10914.945425272981;10968;7937.642806073625;8467.788305292417;8567.914320856711;8595.968483781986;8596.78508037279;15852.68294634124;15905.920470398038;16191.433299834449;16586.419475318307;16620.168991550618;15463;15875.444359447363;16686.49940501787;16832.242549085076;17109.657806843545;10855.185861060294;10939.617113400993;11061.059809916247;11097.889021109686;11120.110391168526;12540.122191446511;12692.936535317263;12707.555235566711;12707.93646031764;12719.364031798188;9982.850257246293;10170.237232207466;10186.236032297458;10275.84586231222;10560.366378017343;10268.486575671037;10328.277020608786;10457.790844182922;10473.371597703857;10641.946790266;8964.68623598171;9050.637974480947;9139.543022848698;9199.632014719604;9293.488858112869;6659.467242620675;6923.515353925177;6924.861502769816;7035.1909530404655;7077.964610176916;7046.2249152594195;7074.964625176841;7162.391196748335;7176.497645164788;7198.49610527279 18:27:17 INFO - PID 23860 | |4;prototype.html;473.6211031175059;502.8843366025815;509.5719595539746;513.1865992402043;526.6024151765416;6064;6068.514518838493;6088.66512341821;6109.647785602541;6135;5726.7422965966525;5995.04327144085;6003.279606447221;6004.699765011754;6005.537729530894;4825.541573550507;4855.417349918015;4907.607391408679;4913.606911447094;4962.15643340633;4835.468098509161;4866.270059491069;4874.2444921037295;4884.998575292057;4936.037472692827;4795.841871157975;4841.927371089437;4848.151573474645;4895.11887860185;4897.706137631736;4653.418322709661;4767.165745994437;4817.301491283744;4834.129856625824;4858.82994095205;4344.717593356421;4353.499347575006;4357.281048626973;4358.7166834156;4376.452943382077;5837.5913686041995;5844.298684157886;5871.970640146772;5936.7328470218945;5976.223090998186;5503.229547863262;5565.193047008162;5572.3870374258795;5577.8605534861545;5626.352969408529;6349.333320001379;6363.995341467423;6406.615603063785;6434.324395938453;6492.707828147744;4749.4063242094735;4775.594074503637;4802.375691160127;4811.017169354987;4827.203511420611;6699.832504187434;6718.865622687567;6759.763408280686;6761.594304341756;6797.456203503659;4914.90170196594;4928;4930.975345123252;4945.851624451272;4958.876028099255;4992.950070499322;4997.275395067695;5005.524475174852;5008.348914641073;5033.345665063592;5536.197251398606;5537.141743029837;5594.244776955059;5598.86002849932;5606.21512988182;6413.839654008687;6435.292117867031;6448.226212854487;6456.903146452807;6457.483401327882;1724.7409391144536;1733.1074496634244;1736.5224563245208;1748.947531574055;1757.3849152796674;1125.954961801535;1200.7118291610125;1205.81912713092;1207.339907627013;1212.4725744301081;5417.349918009864;5509.201165830932;5517.206907754996;5547.33431988164;5684.459976302244;6573.868522629521;6586;6603.306652801482;6638.96680516604;6670.232923213795;5593.916091258634;5612.270404847343;5631.8592035199445;5646.153077038477;5676.659400435987;3443.896683099511;3469.473431690048;3499.5100685903994;3523.066387407339;3537.4340105582983;6213.751449941951;6257.499400047986;6358.682065896686;6383.936160638427;6392.9404827934595;6726.125603671491;6749.39799966027;6762.154730658668;6789.388954994074;6804.285550017276;6385.933363304879;6402.839929001812;6426.614403135827;6428.967855160694;6433.420992110732;6521.706523206372;6528.053432252392;6567.507436942344;6610.636414997221;6611.33886611335;6445.548811583144;6464;6535.44448721864;6550.213974323112;6620.55039635338;6361.427471527585;6363.809085727436;6397.6481293529305;6414.230292364946;6480.611163330215;4874.002488469637;4875.8049678012485;4881.338995753185;4885.560299573055;4920.876978075434;6514.315996820265;6578;6579.499790079739;6619.933800662125;6652.567583107082;6359.523035772243;6397.168368112302;6397.744090236524;6407.871842563216;6421;6228.968855155696;6253.343398943045;6279.215098112736;6354.555181137461;6365.681715914093;6128.908066378919;6209.782657606962;6234.314225435108;6235.565819861366;6270.905936411049;6304.338044505261;6311.495080393465;6316.463100636497;6333.255083336232;6385.116390664858;6119.173911521888;6138.969305153446;6164.167837341902;6171.105189747372;6205.486777854976 18:27:17 INFO - PID 23860 | |5;yui.html;931.2829121576386;931.8089791592722;949.7198326493684;957.3155194036267;961.0725649747992;18460.44618661439;20422;20916.686249706247;21635.783642163573;21765.67351489725;19978.100985455654;20153.395398138044;20364.59270814583;20711;20834.374968750923;1023.2837014090129;1024.9282550221487;1031.3090229546185;1032.9380237185792;1034.1829954336065;983.8966908474614;1027.1731256338644;1031.829748091564;1032.3702541449709;1032.6334151376266;1018.7656838927052;1031.448175226254;1090.9127269818396;1113.0539041814475;1128.3230061962838;1054.4833031814394;1079.8110330692136;1080.0603474976742;1082.1396989393452;1083.6099004358425;791.8495485857726;792.5205250823284;793.9603019848985;794.4677066365549;796.0924546017544;18213.817861821346;18654.16056277471;18779.342723004767;18779.624407511772;19673.114709838093;20004.899975500175;20213.797862021485;20399.592008159903;20432;20567.280145194847;14534.636634084232;14799;14963.251837408086;14989.775153372708;15207.695846083016;3446.7931924084637;3563.982180089083;3577.195131095483;3590.3357878792244;3591.120175556979;105476;106497;110432.89567104306;111636;112273.43863280794;15350.232488375537;15755.606109847346;15821.920890395475;15828.366865325488;15830.60423489422;27899.30251743682;28198.85900570525;28466.146015619564;29077.563836542467;29603;7919.920800791919;8170.754877353689;8173.223543763333;8177.9591102044105;8182.345412366996;3878.670313023368;3941.901452463654;4007.979960100181;4047.0691740899756;4075.8369665213654;5031.84904452867;5046.495350464924;5057.494250574913;5100.081985242692;5108.821191258288;1029.4389557691077;1047.8637777089082;1052.984205236922;1076.4402510694395;1078.148262872322;570.7631332996759;592.5230189697335;611.4558043341341;614.618936259522;629.4177885456027;10886.183536234814;11875.228110172811;11893;11968.222065565711;11978.58074967372;646.5054233511368;653.258551544001;674.4974993629679;675.2369822100994;676.9559978601375;5194.0650682876685;5280.735963201824;5547.667139971614;5566.387697353288;5647.576431767634;91883.540582298;93663;94287;96108;96970;86426;89101;89177.55411222903;89233.55383223172;91244;73086.63456682576;74328.25671743322;78294.60852695814;79180;79214.60392698114;9466.763330916781;9479.526023698925;9824.754381140528;9865.950670246602;10920.2901811382;34723.30553388969;35347.64652353546;36099.0975225611;37652.43521347237;38367.42448863213;64437;67414.66292668505;67440.6627966857;67815.66092169507;70374.64812676108;17740.733888991417;18091.36680216239;18155.909220453814;18195.272189112286;18410.631787364444;19802.306919257757;20688.68966965527;21821.345359639236;21967.340979770634;22054.448638784157;17724.202410891285;18239.179236934637;18638.97485638303;18680.626387472446;19075;17632.382866599608;17866.821331786516;18419;18529.166187521863;18631.534211644816;18075.819241807938;18464.076796160407;18500.444986650422;18766.343177988703;19092.71360929615;11808.409579520818;13901.652458688613;13921.443142274196;14002.509912153026;14236.786448203078;12449.688757781129;13237.338133093499;13413.463461461823;13468.797968030683;13534.79697804514 18:27:17 INFO - PID 23860 | __end_tp_report 18:27:17 INFO - PID 23860 | __start_cc_report 18:27:17 INFO - PID 23860 | _x_x_mozilla_cycle_collect,359 18:27:17 INFO - PID 23860 | __end_cc_report 18:27:17 INFO - PID 23860 | __startTimestamp1499477237505__endTimestamp 18:27:17 INFO - PID 23860 | 18:27:17 INFO - PID 23860 | ------- Summary: start ------- 18:27:17 INFO - PID 23860 | Number of tests: 6 18:27:17 INFO - PID 23860 | 18:27:17 INFO - PID 23860 | [#0] dojo.html Cycles:165 Average:5971.70 Median:6164.85 stddev:697.82 (11.3%) stddev-sans-first:661.57 18:27:17 INFO - PID 23860 | Values: 3062.0 3114.7 3118.7 3145.9 3170.3 5948.7 5961.7 6002.0 6056.7 6061.2 5961.6 6047.5 6095.0 6110.0 6132.3 5553.3 5573.1 5600.1 5601.7 5631.2 5607.5 5631.3 5655.6 5664.3 5674.2 5623.8 5630.3 5636.0 5636.9 5647.9 5607.6 5624.0 5625.6 5634.7 5635.5 5507.6 5575.0 5593.6 5623.5 5705.3 6005.1 6043.0 6070.8 6103.2 6108.0 6362.0 6428.9 6468.6 6521.0 6533.8 6455.7 6493.4 6506.0 6519.3 6525.8 6068.5 6078.2 6083.6 6155.8 6158.9 6696.5 6721.4 6762.5 6762.5 6772.5 6299.1 6383.9 6395.5 6465.7 6492.9 6465.3 6490.9 6501.0 6505.4 6513.8 6319.6 6394.4 6406.6 6457.4 6487.3 5321.6 6337.9 6398.8 6435.5 6464.4 5222.9 5228.9 5289.2 5300.2 5315.0 4485.3 4556.8 4561.5 4568.3 4570.2 5573.5 5593.3 5627.0 5628.0 5635.9 6503.7 6509.3 6520.1 6523.9 6529.4 5589.9 5593.9 5599.3 5613.6 5616.8 4801.0 5690.5 5702.1 5734.2 5737.1 6243.6 6248.2 6311.0 6320.7 6327.2 6490.4 6490.6 6542.0 6575.0 6580.2 6177.3 6246.9 6254.1 6276.8 6354.5 6398.1 6399.8 6418.7 6441.9 6456.7 5180.7 6566.5 6579.5 6664.1 6675.0 6273.0 6314.1 6387.7 6411.9 6421.4 6318.7 6329.7 6412.1 6416.3 6422.6 6154.2 6203.1 6250.2 6253.6 6268.8 6297.8 6329.8 6348.4 6372.9 6404.3 6098.9 6120.2 6135.0 6151.5 6164.8 18:27:17 INFO - PID 23860 | 18:27:17 INFO - PID 23860 | [#1] ext.html Cycles:180 Average:36741.40 Median:3399.27 stddev:51838.28 (1525.0%) stddev-sans-first:51913.53 18:27:17 INFO - PID 23860 | Values: 819.8 842.0 858.3 876.3 884.4 38559.8 40144.6 40295.0 40367.4 40443.8 36111.3 36132.5 36174.0 36361.0 36389.8 6771.0 6893.9 6904.3 6908.1 6926.1 6844.2 6857.4 6892.2 6911.4 6932.9 6796.4 6833.6 6868.0 6911.6 6921.7 6836.0 6852.3 6855.8 6859.8 6859.9 6203.0 6233.7 6245.1 6253.0 6253.8 32862.3 33099.0 33132.7 33177.3 33403.2 3377.4 3421.2 3436.8 3526.0 3638.0 31417.7 31496.1 31511.2 31552.5 31670.0 4668.7 4833.9 4869.6 4944.5 5006.3 191732.0 194283.0 194565.0 194710.0 195012.0 45993.5 46407.5 46746.8 46980.5 47066.0 49322.3 49729.8 49767.3 49775.5 49853.3 16014.4 16031.0 16197.9 16207.4 16207.4 13561.8 13563.7 13565.9 13617.0 13701.2 13985.7 14016.8 14281.1 14287.1 14450.3 5726.3 5752.4 5765.8 5801.6 5900.9 1000.9 1001.5 1006.5 1044.9 1057.5 22432.2 22527.2 22688.8 23489.1 23780.8 1095.6 1098.7 1120.3 1121.1 1124.6 11895.2 11924.6 12155.6 12189.6 12354.3 219878.0 220149.0 220674.0 220696.0 221264.0 51800.5 52022.0 52180.0 52350.0 52384.5 1452.1 1463.4 1496.0 1504.2 1506.0 22079.0 22182.9 22432.8 22692.3 23158.3 36591.3 36816.6 36887.4 36922.8 36952.3 182336.0 182915.0 183969.0 185078.0 185684.0 34718.1 35837.6 36384.5 38471.6 38474.8 46421.1 46954.0 47259.3 47259.8 48039.0 33032.6 33393.3 33473.5 33694.3 33761.8 32228.7 33264.7 33328.3 33497.3 33578.8 35583.0 36517.1 37107.4 37145.4 37147.6 31658.7 32387.7 32604.5 32653.0 32742.5 23915.0 24040.9 24388.3 24606.5 24746.1 18:27:17 INFO - PID 23860 | 18:27:17 INFO - PID 23860 | [#2] jquery.html Cycles:180 Average:33960.29 Median:22362.89 stddev:83114.69 (371.7%) stddev-sans-first:83310.01 18:27:17 INFO - PID 23860 | Values: 554.2 557.2 564.7 577.4 595.4 21550.2 22265.4 22281.3 22534.9 22661.4 25810.7 26067.3 26461.6 26480.0 26706.6 6336.9 6547.2 6558.6 6565.5 6576.7 6123.4 6502.9 6549.1 6566.0 6569.6 6010.3 6297.3 6319.8 6352.6 6360.5 6354.1 6366.8 6367.4 6386.6 6386.7 5885.3 5930.1 5932.4 5935.7 5949.5 27299.6 28299.7 28390.3 28589.3 28680.0 1926.3 1935.1 1937.3 1950.8 1964.2 17851.6 18295.5 18308.4 18341.2 18355.6 2265.1 2305.8 2314.4 2314.4 2405.2 125659.0 126201.0 128171.0 128662.0 129758.0 13909.6 14445.3 14511.6 14845.9 15030.2 23271.3 23357.8 23367.5 23406.5 23440.4 10199.3 10267.4 10357.2 10459.2 10504.6 9675.2 9729.8 9772.1 9868.4 9940.7 8988.5 9037.9 9055.3 9189.1 9222.3 2623.0 2683.5 2751.2 2763.1 2785.5 943.8 946.6 954.8 997.1 998.7 19426.2 19655.5 19969.3 22444.4 24052.9 1034.2 1047.5 1055.4 1063.7 1070.4 11014.6 11094.4 11099.6 11191.2 11465.5 477891.0 493439.0 494475.0 498977.0 512189.0 111301.0 113389.0 114766.0 114801.4 118142.4 1300.0 1310.6 1318.9 1321.5 1324.2 16971.9 17657.7 17713.6 18031.3 18639.2 51063.2 52818.2 53037.2 54090.0 54329.0 66265.0 69994.7 70990.3 71642.0 71670.0 12882.9 13012.4 13267.7 13273.5 13310.2 17725.0 18469.3 18684.8 18833.7 18877.9 15774.4 15900.1 15946.8 16004.9 16072.0 13411.3 13826.2 14385.7 14638.8 14687.9 15298.6 16252.7 16334.0 16435.8 16446.2 12673.1 12987.0 13085.7 13200.3 13296.6 15978.8 16064.7 16076.2 16107.9 16205.1 18:27:17 INFO - PID 23860 | 18:27:17 INFO - PID 23860 | [#3] mootools.html Cycles:180 Average:8395.81 Median:2594.38 stddev:5632.56 (217.1%) stddev-sans-first:5623.24 18:27:17 INFO - PID 23860 | Values: 1316.6 1350.2 1368.3 1372.2 1381.8 13119.7 13591.9 13627.3 13629.9 13655.0 12910.5 13513.8 13815.4 14076.6 14135.4 2555.2 2604.3 2623.3 2629.8 2637.8 2554.6 2598.1 2601.9 2603.7 2613.7 2536.1 2561.3 2578.2 2593.2 2595.6 2557.7 2653.8 2734.8 2741.6 2741.9 2605.7 2620.2 2626.8 2627.3 2628.3 13251.8 13474.4 13552.3 13556.5 13589.0 7317.1 7613.2 7624.4 7626.7 7659.0 4787.5 4838.2 5097.6 5121.8 5133.0 1774.7 1786.0 1820.1 1847.9 1866.5 21851.1 21885.7 21933.0 22004.8 22134.3 5856.5 6173.1 6223.3 6327.5 6343.3 15349.5 15436.2 15437.3 15462.8 15477.3 7376.4 7460.6 7544.0 7561.7 7583.2 6901.3 6913.2 6969.9 6993.6 7019.4 4471.2 4640.7 4660.0 4692.8 4728.7 1456.5 1461.4 1470.7 1473.0 1496.8 870.4 876.9 905.0 909.4 923.8 6917.6 7079.3 7117.2 7127.0 7145.1 715.4 731.2 731.2 737.7 745.7 4179.9 4636.5 4739.9 4770.6 5111.3 17201.7 17876.6 17919.9 17931.0 17974.6 17191.7 17440.9 17771.6 18722.6 18747.6 10431.6 10882.9 10895.8 10914.9 10968.0 7937.6 8467.8 8567.9 8596.0 8596.8 15852.7 15905.9 16191.4 16586.4 16620.2 15463.0 15875.4 16686.5 16832.2 17109.7 10855.2 10939.6 11061.1 11097.9 11120.1 12540.1 12692.9 12707.6 12707.9 12719.4 9982.9 10170.2 10186.2 10275.8 10560.4 10268.5 10328.3 10457.8 10473.4 10641.9 8964.7 9050.6 9139.5 9199.6 9293.5 6659.5 6923.5 6924.9 7035.2 7078.0 7046.2 7075.0 7162.4 7176.5 7198.5 18:27:17 INFO - PID 23860 | 18:27:17 INFO - PID 23860 | [#4] prototype.html Cycles:180 Average:5382.50 Median:5985.63 stddev:1506.95 (25.2%) stddev-sans-first:1465.44 18:27:17 INFO - PID 23860 | Values: 473.6 502.9 509.6 513.2 526.6 6064.0 6068.5 6088.7 6109.6 6135.0 5726.7 5995.0 6003.3 6004.7 6005.5 4825.5 4855.4 4907.6 4913.6 4962.2 4835.5 4866.3 4874.2 4885.0 4936.0 4795.8 4841.9 4848.2 4895.1 4897.7 4653.4 4767.2 4817.3 4834.1 4858.8 4344.7 4353.5 4357.3 4358.7 4376.5 5837.6 5844.3 5872.0 5936.7 5976.2 5503.2 5565.2 5572.4 5577.9 5626.4 6349.3 6364.0 6406.6 6434.3 6492.7 4749.4 4775.6 4802.4 4811.0 4827.2 6699.8 6718.9 6759.8 6761.6 6797.5 4914.9 4928.0 4931.0 4945.9 4958.9 4993.0 4997.3 5005.5 5008.3 5033.3 5536.2 5537.1 5594.2 5598.9 5606.2 6413.8 6435.3 6448.2 6456.9 6457.5 1724.7 1733.1 1736.5 1748.9 1757.4 1126.0 1200.7 1205.8 1207.3 1212.5 5417.3 5509.2 5517.2 5547.3 5684.5 6573.9 6586.0 6603.3 6639.0 6670.2 5593.9 5612.3 5631.9 5646.2 5676.7 3443.9 3469.5 3499.5 3523.1 3537.4 6213.8 6257.5 6358.7 6383.9 6392.9 6726.1 6749.4 6762.2 6789.4 6804.3 6385.9 6402.8 6426.6 6429.0 6433.4 6521.7 6528.1 6567.5 6610.6 6611.3 6445.5 6464.0 6535.4 6550.2 6620.6 6361.4 6363.8 6397.6 6414.2 6480.6 4874.0 4875.8 4881.3 4885.6 4920.9 6514.3 6578.0 6579.5 6619.9 6652.6 6359.5 6397.2 6397.7 6407.9 6421.0 6229.0 6253.3 6279.2 6354.6 6365.7 6128.9 6209.8 6234.3 6235.6 6270.9 6304.3 6311.5 6316.5 6333.3 6385.1 6119.2 6139.0 6164.2 6171.1 6205.5 18:27:17 INFO - PID 23860 | 18:27:17 INFO - PID 23860 | [#5] yui.html Cycles:180 Average:21961.90 Median:20627.98 stddev:28320.85 (137.3%) stddev-sans-first:28356.27 18:27:17 INFO - PID 23860 | Values: 931.3 931.8 949.7 957.3 961.1 18460.4 20422.0 20916.7 21635.8 21765.7 19978.1 20153.4 20364.6 20711.0 20834.4 1023.3 1024.9 1031.3 1032.9 1034.2 983.9 1027.2 1031.8 1032.4 1032.6 1018.8 1031.4 1090.9 1113.1 1128.3 1054.5 1079.8 1080.1 1082.1 1083.6 791.8 792.5 794.0 794.5 796.1 18213.8 18654.2 18779.3 18779.6 19673.1 20004.9 20213.8 20399.6 20432.0 20567.3 14534.6 14799.0 14963.3 14989.8 15207.7 3446.8 3564.0 3577.2 3590.3 3591.1 105476.0 106497.0 110432.9 111636.0 112273.4 15350.2 15755.6 15821.9 15828.4 15830.6 27899.3 28198.9 28466.1 29077.6 29603.0 7919.9 8170.8 8173.2 8178.0 8182.3 3878.7 3941.9 4008.0 4047.1 4075.8 5031.8 5046.5 5057.5 5100.1 5108.8 1029.4 1047.9 1053.0 1076.4 1078.1 570.8 592.5 611.5 614.6 629.4 10886.2 11875.2 11893.0 11968.2 11978.6 646.5 653.3 674.5 675.2 677.0 5194.1 5280.7 5547.7 5566.4 5647.6 91883.5 93663.0 94287.0 96108.0 96970.0 86426.0 89101.0 89177.6 89233.6 91244.0 73086.6 74328.3 78294.6 79180.0 79214.6 9466.8 9479.5 9824.8 9866.0 10920.3 34723.3 35347.6 36099.1 37652.4 38367.4 64437.0 67414.7 67440.7 67815.7 70374.6 17740.7 18091.4 18155.9 18195.3 18410.6 19802.3 20688.7 21821.3 21967.3 22054.4 17724.2 18239.2 18639.0 18680.6 19075.0 17632.4 17866.8 18419.0 18529.2 18631.5 18075.8 18464.1 18500.4 18766.3 19092.7 11808.4 13901.7 13921.4 14002.5 14236.8 12449.7 13237.3 13413.5 13468.8 13534.8 18:27:17 INFO - PID 23860 | -------- Summary: end -------- 18:27:17 INFO - PID 23860 | 18:27:18 INFO - TEST-INFO | 23860: exit 0 18:27:18 INFO - TEST-OK | dromaeo_css | took 1113190ms 18:27:18 INFO - TEST-START | kraken 18:27:18 INFO - Initialising browser for kraken test... 18:27:18 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52938/getInfo.html -profile /tmp/tmpeejJdb/profile 18:27:18 INFO - TEST-INFO | started process 24279 (/builds/slave/test/build/application/firefox/firefox http://localhost:52938/getInfo.html) 18:27:24 INFO - TEST-INFO | 24279: exit 0 18:27:24 INFO - Browser initialized. 18:27:24 INFO - Running cycle 1/1 for kraken test... 18:27:24 INFO - TEST-INFO | started process 24500 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeejJdb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:27:36 INFO - PID 24500 | RSS: Main: 173428736 18:27:36 INFO - PID 24500 | 18:27:38 INFO - PID 24500 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52938/tests/kraken/driver.html?testName=audio-beat-detection) 18:27:39 INFO - PID 24500 | RSS: Main: 177954816 18:27:39 INFO - PID 24500 | 18:27:42 INFO - PID 24500 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52938/tests/kraken/driver.html?testName=audio-dft) 18:27:43 INFO - PID 24500 | RSS: Main: 178556928 18:27:43 INFO - PID 24500 | 18:27:45 INFO - PID 24500 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52938/tests/kraken/driver.html?testName=audio-fft) 18:27:46 INFO - PID 24500 | RSS: Main: 172232704 18:27:46 INFO - PID 24500 | 18:27:48 INFO - PID 24500 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52938/tests/kraken/driver.html?testName=audio-oscillator) 18:27:49 INFO - PID 24500 | RSS: Main: 173400064 18:27:49 INFO - PID 24500 | 18:27:51 INFO - PID 24500 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52938/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:27:52 INFO - PID 24500 | RSS: Main: 173735936 18:27:52 INFO - PID 24500 | 18:27:55 INFO - PID 24500 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52938/tests/kraken/driver.html?testName=imaging-darkroom) 18:27:55 INFO - PID 24500 | RSS: Main: 177016832 18:27:55 INFO - PID 24500 | 18:27:59 INFO - PID 24500 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52938/tests/kraken/driver.html?testName=imaging-desaturate) 18:27:59 INFO - PID 24500 | RSS: Main: 178446336 18:27:59 INFO - PID 24500 | 18:28:02 INFO - PID 24500 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52938/tests/kraken/driver.html?testName=json-parse-financial) 18:28:03 INFO - PID 24500 | RSS: Main: 178003968 18:28:03 INFO - PID 24500 | 18:28:04 INFO - PID 24500 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52938/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:28:05 INFO - PID 24500 | RSS: Main: 177696768 18:28:05 INFO - PID 24500 | 18:28:07 INFO - PID 24500 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52938/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:28:07 INFO - PID 24500 | RSS: Main: 177795072 18:28:07 INFO - PID 24500 | 18:28:09 INFO - PID 24500 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52938/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:28:10 INFO - PID 24500 | RSS: Main: 178585600 18:28:10 INFO - PID 24500 | 18:28:12 INFO - PID 24500 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52938/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:28:13 INFO - PID 24500 | RSS: Main: 177692672 18:28:13 INFO - PID 24500 | 18:28:16 INFO - PID 24500 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52938/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:28:17 INFO - PID 24500 | RSS: Main: 177852416 18:28:17 INFO - PID 24500 | 18:28:19 INFO - PID 24500 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52938/tests/kraken/driver.html?testName=ai-astar) 18:28:19 INFO - PID 24500 | RSS: Main: 179351552 18:28:19 INFO - PID 24500 | 18:28:19 INFO - PID 24500 | __start_tp_report 18:28:19 INFO - PID 24500 | _x_x_mozilla_page_load 18:28:19 INFO - PID 24500 | _x_x_mozilla_page_load_details 18:28:19 INFO - PID 24500 | |i|pagename|runs| 18:28:19 INFO - PID 24500 | |0;ai-astar;100;108;109;108;108;108;108;111;110;110 18:28:19 INFO - PID 24500 | |1;audio-beat-detection;160;125;150;176;131;155;149;121;177;126 18:28:19 INFO - PID 24500 | |2;audio-dft;165;164;165;161;163;170;165;166;166;165 18:28:19 INFO - PID 24500 | |3;audio-fft;75;75;76;184;74;75;76;75;96;77 18:28:19 INFO - PID 24500 | |4;audio-oscillator;83;81;132;82;83;81;142;82;83;132 18:28:19 INFO - PID 24500 | |5;imaging-gaussian-blur;113;114;114;115;114;114;114;114;114;114 18:28:19 INFO - PID 24500 | |6;imaging-darkroom;150;149;149;148;149;149;148;150;150;150 18:28:19 INFO - PID 24500 | |7;imaging-desaturate;94;95;95;95;95;94;94;94;94;97 18:28:19 INFO - PID 24500 | |8;json-parse-financial;60;56;55;56;55;55;54;55;55;54 18:28:19 INFO - PID 24500 | |9;json-stringify-tinderbox;53;53;54;54;55;54;54;55;54;54 18:28:19 INFO - PID 24500 | |10;stanford-crypto-aes;78;77;77;98;79;78;78;78;78;78 18:28:19 INFO - PID 24500 | |11;stanford-crypto-ccm;132;125;130;132;130;134;126;129;135;148 18:28:19 INFO - PID 24500 | |12;stanford-crypto-pbkdf2;182;180;185;182;182;184;188;188;190;182 18:28:19 INFO - PID 24500 | |13;stanford-crypto-sha256-iterative;68;76;69;68;72;68;68;68;67;68 18:28:19 INFO - PID 24500 | __end_tp_report 18:28:19 INFO - PID 24500 | __start_cc_report 18:28:19 INFO - PID 24500 | _x_x_mozilla_cycle_collect,932 18:28:19 INFO - PID 24500 | __end_cc_report 18:28:19 INFO - PID 24500 | __startTimestamp1499477299406__endTimestamp 18:28:19 INFO - PID 24500 | 18:28:19 INFO - PID 24500 | ------- Summary: start ------- 18:28:19 INFO - PID 24500 | Number of tests: 14 18:28:19 INFO - PID 24500 | 18:28:19 INFO - PID 24500 | [#0] ai-astar Cycles:10 Average:108.00 Median:108.50 stddev:3.02 (2.8%) stddev-sans-first:1.17 18:28:19 INFO - PID 24500 | Values: 100.0 108.0 109.0 108.0 108.0 108.0 108.0 111.0 110.0 110.0 18:28:19 INFO - PID 24500 | 18:28:19 INFO - PID 24500 | [#1] audio-beat-detection Cycles:10 Average:147.00 Median:152.50 stddev:20.67 (13.6%) stddev-sans-first:21.38 18:28:19 INFO - PID 24500 | Values: 160.0 125.0 150.0 176.0 131.0 155.0 149.0 121.0 177.0 126.0 18:28:19 INFO - PID 24500 | 18:28:19 INFO - PID 24500 | [#2] audio-dft Cycles:10 Average:165.00 Median:165.00 stddev:2.31 (1.4%) stddev-sans-first:2.45 18:28:19 INFO - PID 24500 | Values: 165.0 164.0 165.0 161.0 163.0 170.0 165.0 166.0 166.0 165.0 18:28:19 INFO - PID 24500 | 18:28:19 INFO - PID 24500 | [#3] audio-fft Cycles:10 Average:88.30 Median:75.50 stddev:34.25 (45.4%) stddev-sans-first:35.99 18:28:19 INFO - PID 24500 | Values: 75.0 75.0 76.0 184.0 74.0 75.0 76.0 75.0 96.0 77.0 18:28:19 INFO - PID 24500 | 18:28:19 INFO - PID 24500 | [#4] audio-oscillator Cycles:10 Average:98.10 Median:82.00 stddev:25.85 (31.5%) stddev-sans-first:26.83 18:28:19 INFO - PID 24500 | Values: 83.0 81.0 132.0 82.0 83.0 81.0 142.0 82.0 83.0 132.0 18:28:19 INFO - PID 24500 | 18:28:19 INFO - PID 24500 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 18:28:19 INFO - PID 24500 | Values: 113.0 114.0 114.0 115.0 114.0 114.0 114.0 114.0 114.0 114.0 18:28:19 INFO - PID 24500 | 18:28:19 INFO - PID 24500 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:149.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 18:28:19 INFO - PID 24500 | Values: 150.0 149.0 149.0 148.0 149.0 149.0 148.0 150.0 150.0 150.0 18:28:19 INFO - PID 24500 | 18:28:19 INFO - PID 24500 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.95 (1.0%) stddev-sans-first:0.97 18:28:19 INFO - PID 24500 | Values: 94.0 95.0 95.0 95.0 95.0 94.0 94.0 94.0 94.0 97.0 18:28:19 INFO - PID 24500 | 18:28:19 INFO - PID 24500 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.00 stddev:1.72 (3.1%) stddev-sans-first:0.71 18:28:19 INFO - PID 24500 | Values: 60.0 56.0 55.0 56.0 55.0 55.0 54.0 55.0 55.0 54.0 18:28:19 INFO - PID 24500 | 18:28:19 INFO - PID 24500 | [#9] json-stringify-tinderbox Cycles:10 Average:54.00 Median:54.00 stddev:0.67 (1.2%) stddev-sans-first:0.60 18:28:19 INFO - PID 24500 | Values: 53.0 53.0 54.0 54.0 55.0 54.0 54.0 55.0 54.0 54.0 18:28:19 INFO - PID 24500 | 18:28:19 INFO - PID 24500 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:78.00 stddev:6.38 (8.2%) stddev-sans-first:6.74 18:28:19 INFO - PID 24500 | Values: 78.0 77.0 77.0 98.0 79.0 78.0 78.0 78.0 78.0 78.0 18:28:19 INFO - PID 24500 | 18:28:19 INFO - PID 24500 | [#11] stanford-crypto-ccm Cycles:10 Average:132.10 Median:132.00 stddev:6.42 (4.9%) stddev-sans-first:6.81 18:28:19 INFO - PID 24500 | Values: 132.0 125.0 130.0 132.0 130.0 134.0 126.0 129.0 135.0 148.0 18:28:19 INFO - PID 24500 | 18:28:19 INFO - PID 24500 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.30 Median:184.50 stddev:3.33 (1.8%) stddev-sans-first:3.43 18:28:19 INFO - PID 24500 | Values: 182.0 180.0 185.0 182.0 182.0 184.0 188.0 188.0 190.0 182.0 18:28:19 INFO - PID 24500 | 18:28:19 INFO - PID 24500 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:68.00 stddev:2.74 (4.0%) stddev-sans-first:2.87 18:28:19 INFO - PID 24500 | Values: 68.0 76.0 69.0 68.0 72.0 68.0 68.0 68.0 67.0 68.0 18:28:19 INFO - PID 24500 | -------- Summary: end -------- 18:28:19 INFO - PID 24500 | 18:28:19 INFO - PID 24500 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:28:20 INFO - TEST-INFO | 24500: exit 0 18:28:20 INFO - TEST-OK | kraken | took 62091ms 18:28:20 INFO - SUITE-END | took 1175s 18:28:20 INFO - Completed test suite (00:19:35) 18:28:20 INFO - javascript benchmark 18:28:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8216.720325623237, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3061.954070688939, 3114.719675229229, 3118.672539383365, 3145.889893853715, 3170.2708377073286, 5948.672822994739, 5961.672108034057, 6001.9699901500435, 6056.727447264872, 6061.151438798566, 5961.552883533742, 6047.4859636930805, 6095.024796032636, 6109.969450152754, 6132.264128304599, 5553.305836770403, 5573.052581061219, 5600.131979543177, 5601.691906945116, 5631.18347839563, 5607.495325420711, 5631.267935168423, 5655.604107712462, 5664.320281566218, 5674.205611214413, 5623.831285061455, 5630.268065151525, 5636.041872881599, 5636.915446268309, 5647.943520564803, 5607.607467477278, 5623.971880140573, 5625.578081643893, 5634.7182640867795, 5635.492805647511, 5507.614466987313, 5575.0, 5593.580481463866, 5623.465770751772, 5705.343885453143, 6005.069214271794, 6043.0, 6070.787522436738, 6103.176071230371, 6107.992181290082, 6361.968190159066, 6428.871422571569, 6468.611883287018, 6520.967395163041, 6533.803985880431, 6455.709493072823, 6493.350664933516, 6506.0, 6519.315471875432, 6525.804225873231, 6068.514518838482, 6078.209832721718, 6083.574149809515, 6155.784547540859, 6158.938410615881, 6696.497762667819, 6721.395074443323, 6762.459003279726, 6762.492813039042, 6772.458203343721, 6299.118123462719, 6383.936160638427, 6395.488360931115, 6465.676716164173, 6492.902606460907, 6465.288818229991, 6490.870182596416, 6500.967495162588, 6505.41451269388, 6513.804585862432, 6319.6208227506495, 6394.392532709385, 6406.551541392151, 6457.354264573505, 6487.2539657939, 5321.624294662605, 6337.904931426032, 6398.840028999312, 6435.549511534241, 6464.353564643592, 5222.947770522323, 5228.9477105229225, 5289.18017707256, 5300.178472336717, 5314.973425132927, 4485.349624304457, 4556.8177272908715, 4561.521040290788, 4568.314752787042, 4570.177368073712, 5573.470520300565, 5593.328800543961, 5627.043402621564, 5628.04323265046, 5635.915461268084, 6503.674816259168, 6509.251436084911, 6520.054592084216, 6523.902141467882, 6529.444997175198, 5589.916151257735, 5593.888122237614, 5599.272094627672, 5613.578981576398, 5616.803411880564, 4800.9917056562135, 5690.459406356389, 5702.116171993348, 5734.168545560954, 5737.110747834093, 6243.562950593415, 6248.156498872685, 6310.968445157745, 6320.747170113144, 6327.177466929362, 6490.383413575702, 6490.643014634241, 6542.0, 6575.046618240424, 6580.243272023587, 6177.2587289525545, 6246.875062498815, 6254.124422580751, 6276.811695649138, 6354.4598709108395, 6398.104265402941, 6399.8080057598345, 6418.743250270124, 6441.871162576628, 6456.6771661415805, 5180.7409629519125, 6566.540342176002, 6579.539432239889, 6664.067030615621, 6675.03212034262, 6272.968635156795, 6314.084457753692, 6387.712552935036, 6411.903821442589, 6421.389967953037, 6318.6840657965995, 6329.6518691470565, 6412.1023056771155, 6416.294207637063, 6422.614643121427, 6154.1999540059505, 6203.100550420074, 6250.218722659668, 6253.624782513064, 6268.811935641938, 6297.811065668037, 6329.841753956188, 6348.428641422294, 6372.904406434, 6404.327545607831, 6098.878022439438, 6120.234970628671, 6135.0, 6151.538634602333, 6164.845878853064], "value": 5922.043511200458, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [819.7786597618643, 841.9663213471462, 858.2790456016945, 876.3033388456176, 884.4428010353479, 38559.807200964024, 40144.598554014454, 40294.99262518442, 40367.39448908269, 40443.797781011126, 36111.2777744445, 36132.45801312982, 36174.0, 36361.0, 36389.81805090971, 6770.96614516928, 6893.896591551131, 6904.3095690431055, 6908.101946746916, 6926.064981227545, 6844.2129155147295, 6857.3828355448, 6892.241853396123, 6911.377975982161, 6932.861342773142, 6796.354346337115, 6833.555818871782, 6867.965660171692, 6911.619860907648, 6921.723131074751, 6836.008778727107, 6852.280510546396, 6855.794326170223, 6859.7652422563915, 6859.897101543481, 6202.96898515509, 6233.688315584248, 6245.063240513914, 6253.030780229072, 6253.843653908643, 32862.34275314504, 33099.0, 33132.6686733132, 33177.3364532708, 33403.16492087717, 3377.375185590649, 3421.161815355254, 3436.8281585920604, 3526.0303416560396, 3638.0, 31417.74329026836, 31496.055118346485, 31511.212219694462, 31552.526712099338, 31670.0, 4668.696534725266, 4833.879153021167, 4869.610431165498, 4944.505549445063, 5006.349174607314, 191732.0, 194283.0, 194565.02717486463, 194710.0, 195012.0, 45993.5400645996, 46407.53592464099, 46746.76626616845, 46980.5301946983, 47066.0, 49322.260166097534, 49729.751351243736, 49767.25349119766, 49775.50224497781, 49853.25220121701, 16014.359425623077, 16031.0, 16197.919010405109, 16207.351705931631, 16207.432739854048, 13561.796573051412, 13563.66090847717, 13565.86434135646, 13617.0, 13701.246431446367, 13985.650358741113, 14016.789748153786, 14281.071730337495, 14287.071340362843, 14450.277486125651, 5726.312842458931, 5752.395998420106, 5765.827025189251, 5801.622894511843, 5900.881982360329, 1000.9349392289478, 1001.5092604623827, 1006.5269323417982, 1044.9164066874632, 1057.5082586597268, 22432.21487247971, 22527.211547595754, 22688.773112268667, 23489.060437582306, 23780.762192378203, 1095.6001059613343, 1098.6649072033106, 1120.2662256222188, 1121.1199208621356, 1124.612008856943, 11895.226810257305, 11924.642260732191, 12155.574554890713, 12189.573364932185, 12354.320512371725, 219878.0, 220149.0, 220674.0, 220696.0, 221264.0, 51800.481995179565, 52022.0, 52180.0, 52350.0, 52384.47615523796, 1452.0561634937164, 1463.4073200353873, 1495.9700805983819, 1504.2253239581405, 1505.9504503380742, 22079.0, 22182.88908555447, 22432.775672243723, 22692.319230423112, 23158.305250842503, 36591.26817463583, 36816.63183368132, 36887.44668829916, 36922.8153859229, 36952.26095478021, 182336.0, 182915.0, 183969.0, 185078.0, 185684.0, 34718.132046698025, 35837.64162358343, 36384.454233187054, 38471.615283847925, 38474.807625961694, 46421.1431542748, 46954.0, 47259.291110634054, 47259.76370118128, 48039.0, 33032.64752142425, 33393.33213335768, 33473.497897531066, 33694.326113478084, 33761.83119084389, 32228.67771322257, 33264.66735332616, 33328.33343333168, 33497.330053398306, 33578.83210583931, 35583.0, 36517.08707282339, 37107.443388348656, 37145.442818358286, 37147.62852371442, 31658.683413165574, 32387.67612323941, 32604.510932336507, 32653.0, 32742.50886236661, 23915.043398263875, 24040.87979560091, 24388.26835194947, 24606.507869842146, 24746.133885314648], "value": 16742.390537489897, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.2434576802666, 557.1696975435694, 564.6837770848325, 577.3908526504539, 595.3778301674749, 21550.245741399034, 22265.44336391591, 22281.331560053182, 22534.887325563348, 22661.43346416336, 25810.741892581067, 26067.348316292104, 26461.603075953826, 26480.0, 26706.599401009, 6336.873262534747, 6547.181602299713, 6558.573692709982, 6565.507586930976, 6576.6711664416825, 6123.357047510014, 6502.93497065028, 6549.148610680605, 6566.047923051155, 6569.572977756455, 6010.27876654802, 6297.3387794281625, 6319.842003949892, 6352.587081839689, 6360.491160707133, 6354.078658594501, 6366.840828979266, 6367.363263673618, 6386.552941294065, 6386.712597933104, 5885.293764748215, 5930.140129681172, 5932.377100404482, 5935.703214839241, 5949.524038076944, 27299.590506142424, 28299.71700283012, 28390.29024274389, 28589.28526786826, 28680.0, 1926.3354142820704, 1935.1195206181153, 1937.3122541497705, 1950.775660798998, 1964.165229777339, 17851.553711157194, 18295.451136465927, 18308.359207427675, 18341.17464714078, 18355.632887342177, 2265.127925748582, 2305.7578954209735, 2314.36355002374, 2314.4213946513373, 2405.2183040511904, 125659.0, 126201.0, 128171.0, 128662.0, 129758.0, 13909.58271251864, 14445.277736113363, 14511.637209069646, 14845.92577037108, 15030.17334046616, 23271.301860944197, 23357.76642233556, 23367.53264934692, 23406.531869362516, 23440.413989650395, 10199.337043092175, 10267.383956962607, 10357.171426285879, 10459.215558833119, 10504.579816807242, 9675.177609903238, 9729.805403891882, 9772.12050915421, 9868.407895526148, 9940.652077177265, 8988.505632190292, 9037.881930733885, 9055.275577953747, 9189.127032931861, 9222.262219022463, 2622.960655590168, 2683.5303821831103, 2751.2296556964084, 2763.115802943039, 2785.5264605017196, 943.7923656795494, 946.6118891254553, 954.8185844689486, 997.0926456924309, 998.6554638649654, 19426.22295108208, 19655.50861228452, 19969.302609278373, 22444.438889027577, 24052.87973560121, 1034.2088302448633, 1047.4814966591434, 1055.4406164732704, 1063.6596289187385, 1070.4005756776075, 11014.614488492864, 11094.389808560445, 11099.5560177592, 11191.16066295015, 11465.54137834494, 477891.0, 493439.0, 494475.0, 498977.0, 512189.0, 111301.0, 113389.0, 114766.0, 114801.4259928695, 118142.40928795472, 1299.9870001299867, 1310.6133690561308, 1318.8813006829432, 1321.4846209978116, 1324.1657755614094, 16971.91514042422, 17657.735133972743, 17713.557161071076, 18031.278748849898, 18639.161237744604, 51063.234051488515, 52818.20772688336, 53037.20444193418, 54090.0, 54329.0, 66265.0, 69994.65002674954, 70990.29009710043, 71642.0, 71670.0, 12882.935585322013, 13012.414441349973, 13267.66830829237, 13273.469061237442, 13310.201387916755, 17725.025123618325, 18469.261229550666, 18684.813151868308, 18833.71749423787, 18877.90561047186, 15774.447894323643, 15900.12549309799, 15946.840531594535, 16004.91997540005, 16072.0, 13411.262380569162, 13826.239556824472, 14385.712285754436, 14638.780418293522, 14687.853121468648, 15298.617534561725, 16252.67494650124, 16334.0, 16435.753463697816, 16446.177691115634, 12673.112882098534, 12987.0, 13085.738285234433, 13200.339983001004, 13296.601101966957, 15978.760318594997, 16064.678706425571, 16076.196190190678, 16107.919460402623, 16205.108719020096], "value": 11565.684628853056, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.5589527508284, 1350.243863436475, 1368.2611389849483, 1372.1629805818454, 1381.8341798984122, 13119.737605247888, 13591.932040339796, 13627.318634068306, 13629.863701362983, 13655.04414690972, 12910.548130815423, 13513.797293040612, 13815.37830797614, 14076.57770266891, 14135.434582616683, 2555.2334299710105, 2604.2968398532385, 2623.34416395901, 2629.7764690001372, 2637.841729496227, 2554.6423500709916, 2598.0646967091834, 2601.856897870616, 2603.6745406824148, 2613.686357637086, 2536.112360673768, 2561.3212498687863, 2578.2136448383235, 2593.1701855406277, 2595.584706446969, 2557.7442255774367, 2653.761161495465, 2734.8359098454157, 2741.643586333784, 2741.9040333588428, 2605.674290713661, 2620.227033025243, 2626.776723978464, 2627.303764502389, 2628.264086055888, 13251.801222981663, 13474.393652285671, 13552.322383880864, 13556.525521606696, 13589.048766586342, 7317.085364329459, 7613.200613935568, 7624.428167887375, 7626.694932202705, 7659.042619672541, 4787.521247875219, 4838.153323168432, 5097.5667068299235, 5121.820736274212, 5133.024725302218, 1774.7249176377682, 1785.9910700446414, 1820.1172431370774, 1847.8891266524051, 1866.542697039234, 21851.125954961783, 21885.67171492429, 21933.0, 22004.77995220043, 22134.33596992077, 5856.472917437451, 6173.104899789505, 6223.253209614784, 6327.4938004959495, 6343.333949935282, 15349.462768803038, 15436.228188590525, 15437.30532126057, 15462.845371546366, 15477.303521341342, 7376.446766492427, 7460.626968651546, 7544.0, 7561.735339263099, 7583.165851756303, 6901.275366086589, 6913.170419549686, 6969.9303006969285, 6993.580385176906, 7019.403350715144, 4471.1728330259, 4640.69835460694, 4659.998100408428, 4692.835750748707, 4728.71627702339, 1456.4829485532696, 1461.4081297074702, 1470.7205630930089, 1472.9852701472848, 1496.760518317064, 870.4037734152126, 876.8860048193694, 904.9728508144766, 909.3679892474667, 923.8198551282435, 6917.584944903322, 7079.2920707929825, 7117.181524124792, 7127.002219689248, 7145.1068616422945, 715.4312321704153, 731.184729027131, 731.1883808972037, 737.7049180327912, 745.7091734223549, 4179.874603761892, 4636.513166117509, 4739.881502962385, 4770.618350532019, 5111.309973153651, 17201.7419738704, 17876.55308617295, 17919.910400447916, 17931.0, 17974.640507189783, 17191.656166876593, 17440.912795435943, 17771.644567108844, 18722.625547488973, 18747.625047499245, 10431.634892778717, 10882.945585272022, 10895.782084358269, 10914.945425272981, 10968.0, 7937.642806073625, 8467.788305292417, 8567.914320856711, 8595.968483781986, 8596.78508037279, 15852.68294634124, 15905.920470398038, 16191.433299834449, 16586.419475318307, 16620.168991550618, 15463.0, 15875.444359447363, 16686.49940501787, 16832.242549085076, 17109.657806843545, 10855.185861060294, 10939.617113400993, 11061.059809916247, 11097.889021109686, 11120.110391168526, 12540.122191446511, 12692.936535317263, 12707.555235566711, 12707.93646031764, 12719.364031798188, 9982.850257246293, 10170.237232207466, 10186.236032297458, 10275.84586231222, 10560.366378017343, 10268.486575671037, 10328.277020608786, 10457.790844182922, 10473.371597703857, 10641.946790266, 8964.68623598171, 9050.637974480947, 9139.543022848698, 9199.632014719604, 9293.488858112869, 6659.467242620675, 6923.515353925177, 6924.861502769816, 7035.1909530404655, 7077.964610176916, 7046.2249152594195, 7074.964625176841, 7162.391196748335, 7176.497645164788, 7198.49610527279], "value": 6145.092273403009, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [473.6211031175059, 502.8843366025815, 509.5719595539746, 513.1865992402043, 526.6024151765416, 6064.0, 6068.514518838493, 6088.66512341821, 6109.647785602541, 6135.0, 5726.7422965966525, 5995.04327144085, 6003.279606447221, 6004.699765011754, 6005.537729530894, 4825.541573550507, 4855.417349918015, 4907.607391408679, 4913.606911447094, 4962.15643340633, 4835.468098509161, 4866.270059491069, 4874.2444921037295, 4884.998575292057, 4936.037472692827, 4795.841871157975, 4841.927371089437, 4848.151573474645, 4895.11887860185, 4897.706137631736, 4653.418322709661, 4767.165745994437, 4817.301491283744, 4834.129856625824, 4858.82994095205, 4344.717593356421, 4353.499347575006, 4357.281048626973, 4358.7166834156, 4376.452943382077, 5837.5913686041995, 5844.298684157886, 5871.970640146772, 5936.7328470218945, 5976.223090998186, 5503.229547863262, 5565.193047008162, 5572.3870374258795, 5577.8605534861545, 5626.352969408529, 6349.333320001379, 6363.995341467423, 6406.615603063785, 6434.324395938453, 6492.707828147744, 4749.4063242094735, 4775.594074503637, 4802.375691160127, 4811.017169354987, 4827.203511420611, 6699.832504187434, 6718.865622687567, 6759.763408280686, 6761.594304341756, 6797.456203503659, 4914.90170196594, 4928.0, 4930.975345123252, 4945.851624451272, 4958.876028099255, 4992.950070499322, 4997.275395067695, 5005.524475174852, 5008.348914641073, 5033.345665063592, 5536.197251398606, 5537.141743029837, 5594.244776955059, 5598.86002849932, 5606.21512988182, 6413.839654008687, 6435.292117867031, 6448.226212854487, 6456.903146452807, 6457.483401327882, 1724.7409391144536, 1733.1074496634244, 1736.5224563245208, 1748.947531574055, 1757.3849152796674, 1125.954961801535, 1200.7118291610125, 1205.81912713092, 1207.339907627013, 1212.4725744301081, 5417.349918009864, 5509.201165830932, 5517.206907754996, 5547.33431988164, 5684.459976302244, 6573.868522629521, 6586.0, 6603.306652801482, 6638.96680516604, 6670.232923213795, 5593.916091258634, 5612.270404847343, 5631.8592035199445, 5646.153077038477, 5676.659400435987, 3443.896683099511, 3469.473431690048, 3499.5100685903994, 3523.066387407339, 3537.4340105582983, 6213.751449941951, 6257.499400047986, 6358.682065896686, 6383.936160638427, 6392.9404827934595, 6726.125603671491, 6749.39799966027, 6762.154730658668, 6789.388954994074, 6804.285550017276, 6385.933363304879, 6402.839929001812, 6426.614403135827, 6428.967855160694, 6433.420992110732, 6521.706523206372, 6528.053432252392, 6567.507436942344, 6610.636414997221, 6611.33886611335, 6445.548811583144, 6464.0, 6535.44448721864, 6550.213974323112, 6620.55039635338, 6361.427471527585, 6363.809085727436, 6397.6481293529305, 6414.230292364946, 6480.611163330215, 4874.002488469637, 4875.8049678012485, 4881.338995753185, 4885.560299573055, 4920.876978075434, 6514.315996820265, 6578.0, 6579.499790079739, 6619.933800662125, 6652.567583107082, 6359.523035772243, 6397.168368112302, 6397.744090236524, 6407.871842563216, 6421.0, 6228.968855155696, 6253.343398943045, 6279.215098112736, 6354.555181137461, 6365.681715914093, 6128.908066378919, 6209.782657606962, 6234.314225435108, 6235.565819861366, 6270.905936411049, 6304.338044505261, 6311.495080393465, 6316.463100636497, 6333.255083336232, 6385.116390664858, 6119.173911521888, 6138.969305153446, 6164.167837341902, 6171.105189747372, 6205.486777854976], "value": 4940.570923570045, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [931.2829121576386, 931.8089791592722, 949.7198326493684, 957.3155194036267, 961.0725649747992, 18460.44618661439, 20422.0, 20916.686249706247, 21635.783642163573, 21765.67351489725, 19978.100985455654, 20153.395398138044, 20364.59270814583, 20711.0, 20834.374968750923, 1023.2837014090129, 1024.9282550221487, 1031.3090229546185, 1032.9380237185792, 1034.1829954336065, 983.8966908474614, 1027.1731256338644, 1031.829748091564, 1032.3702541449709, 1032.6334151376266, 1018.7656838927052, 1031.448175226254, 1090.9127269818396, 1113.0539041814475, 1128.3230061962838, 1054.4833031814394, 1079.8110330692136, 1080.0603474976742, 1082.1396989393452, 1083.6099004358425, 791.8495485857726, 792.5205250823284, 793.9603019848985, 794.4677066365549, 796.0924546017544, 18213.817861821346, 18654.16056277471, 18779.342723004767, 18779.624407511772, 19673.114709838093, 20004.899975500175, 20213.797862021485, 20399.592008159903, 20432.0, 20567.280145194847, 14534.636634084232, 14799.0, 14963.251837408086, 14989.775153372708, 15207.695846083016, 3446.7931924084637, 3563.982180089083, 3577.195131095483, 3590.3357878792244, 3591.120175556979, 105476.0, 106497.0, 110432.89567104306, 111636.0, 112273.43863280794, 15350.232488375537, 15755.606109847346, 15821.920890395475, 15828.366865325488, 15830.60423489422, 27899.30251743682, 28198.85900570525, 28466.146015619564, 29077.563836542467, 29603.0, 7919.920800791919, 8170.754877353689, 8173.223543763333, 8177.9591102044105, 8182.345412366996, 3878.670313023368, 3941.901452463654, 4007.979960100181, 4047.0691740899756, 4075.8369665213654, 5031.84904452867, 5046.495350464924, 5057.494250574913, 5100.081985242692, 5108.821191258288, 1029.4389557691077, 1047.8637777089082, 1052.984205236922, 1076.4402510694395, 1078.148262872322, 570.7631332996759, 592.5230189697335, 611.4558043341341, 614.618936259522, 629.4177885456027, 10886.183536234814, 11875.228110172811, 11893.0, 11968.222065565711, 11978.58074967372, 646.5054233511368, 653.258551544001, 674.4974993629679, 675.2369822100994, 676.9559978601375, 5194.0650682876685, 5280.735963201824, 5547.667139971614, 5566.387697353288, 5647.576431767634, 91883.540582298, 93663.0, 94287.0, 96108.0, 96970.0, 86426.0, 89101.0, 89177.55411222903, 89233.55383223172, 91244.0, 73086.63456682576, 74328.25671743322, 78294.60852695814, 79180.0, 79214.60392698114, 9466.763330916781, 9479.526023698925, 9824.754381140528, 9865.950670246602, 10920.2901811382, 34723.30553388969, 35347.64652353546, 36099.0975225611, 37652.43521347237, 38367.42448863213, 64437.0, 67414.66292668505, 67440.6627966857, 67815.66092169507, 70374.64812676108, 17740.733888991417, 18091.36680216239, 18155.909220453814, 18195.272189112286, 18410.631787364444, 19802.306919257757, 20688.68966965527, 21821.345359639236, 21967.340979770634, 22054.448638784157, 17724.202410891285, 18239.179236934637, 18638.97485638303, 18680.626387472446, 19075.0, 17632.382866599608, 17866.821331786516, 18419.0, 18529.166187521863, 18631.534211644816, 18075.819241807938, 18464.076796160407, 18500.444986650422, 18766.343177988703, 19092.71360929615, 11808.409579520818, 13901.652458688613, 13921.443142274196, 14002.509912153026, 14236.786448203078, 12449.688757781129, 13237.338133093499, 13413.463461461823, 13468.797968030683, 13534.79697804514], "value": 8838.888902248536, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1539.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 108.0, 109.0, 108.0, 108.0, 108.0, 108.0, 111.0, 110.0, 110.0], "value": 108.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 125.0, 150.0, 176.0, 131.0, 155.0, 149.0, 121.0, 177.0, 126.0], "value": 147.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 165.0, 161.0, 163.0, 170.0, 165.0, 166.0, 166.0, 165.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 184.0, 74.0, 75.0, 76.0, 75.0, 96.0, 77.0], "value": 88.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 132.0, 82.0, 83.0, 81.0, 142.0, 82.0, 83.0, 132.0], "value": 98.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 149.0, 148.0, 149.0, 149.0, 148.0, 150.0, 150.0, 150.0], "value": 149.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 97.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 56.0, 55.0, 56.0, 55.0, 55.0, 54.0, 55.0, 55.0, 54.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 54.0, 55.0, 54.0, 54.0, 55.0, 54.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 77.0, 98.0, 79.0, 78.0, 78.0, 78.0, 78.0, 78.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 125.0, 130.0, 132.0, 130.0, 134.0, 126.0, 129.0, 135.0, 148.0], "value": 132.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 180.0, 185.0, 182.0, 182.0, 184.0, 188.0, 188.0, 190.0, 182.0], "value": 184.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 76.0, 69.0, 68.0, 72.0, 68.0, 68.0, 68.0, 67.0, 68.0], "value": 69.2, "unit": "score"}]}]} 18:28:20 INFO - Return code: 0 18:28:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:28:20 INFO - # TBPL SUCCESS # 18:28:20 INFO - Running post-action listener: _package_coverage_data 18:28:20 INFO - Running post-action listener: _resource_record_post_action 18:28:20 INFO - [mozharness: 2017-07-08 01:28:20.701901Z] Finished run-tests step (success) 18:28:20 INFO - Running post-run listener: _resource_record_post_run 18:28:20 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 16384; Write bytes: 435433472; Read time: 660; Write time: 727280 18:28:20 INFO - TinderboxPrint: CPU usage
13.1% 18:28:20 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 660 18:28:20 INFO - TinderboxPrint: I/O write bytes / time
435,433,472 / 727,280 18:28:20 INFO - TinderboxPrint: CPU idle
8,268.1 (86.8%) 18:28:20 INFO - TinderboxPrint: CPU user
1,199.5 (12.6%) 18:28:20 INFO - TinderboxPrint: Swap in / out
0 / 0 18:28:20 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 107110400; Read time: 40; Write time: 190804 18:28:20 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:28:20 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 8192; Write bytes: 325689344; Read time: 604; Write time: 536012 18:28:21 INFO - Running post-run listener: _upload_blobber_files 18:28:21 INFO - Blob upload gear active. 18:28:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:28:21 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 18:28:21 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'] 18:28:21 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 18:28:21 INFO - (blobuploader) - INFO - Open directory for files ... 18:28:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:28:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:28:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:28:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:28:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:28:25 INFO - (blobuploader) - INFO - Done attempting. 18:28:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:28:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:28:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:28:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:28:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:28:26 INFO - (blobuploader) - INFO - Done attempting. 18:28:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:28:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:28:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:28:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:28:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:28:27 INFO - (blobuploader) - INFO - Done attempting. 18:28:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:28:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:28:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:28:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:28:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:28:28 INFO - (blobuploader) - INFO - Done attempting. 18:28:28 INFO - (blobuploader) - INFO - Iteration through files over. 18:28:28 INFO - Return code: 0 18:28:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:28:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:28:28 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63cc6b8fd5595b4787120b5302c9af3c66d66aeca6aca24e5ae560a18729f46d454ba37b0a491fa98850abc31c3cc35a00b443f6cd40d3c2859b83f2c9d374db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fca86acce9a301362264ff4c85acf9aa4ea5035b84d5e0326716ac86389b85298df3dfe40ad8dd902779ce4d590c4b5077f2810b621efa03148790d5a3195f2c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e7a0861f1fa8dc629e76c7a6fa27a8bd6a5970564124d6809b695c143f803c00f503e13322637bf5970c7773a5bff5d25568e42fa548ebd5a6d17f18fa422de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fcc083eea3d945e00264a886138330534bd37ed6320b7f38b3b107adcb2fabca2747a2130d0c4a9741f572f9aa4ddaf5a0c4edb5f096f7d314cbf9d94b8e4f45"} 18:28:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:28:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:28:28 INFO - Contents: 18:28:28 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63cc6b8fd5595b4787120b5302c9af3c66d66aeca6aca24e5ae560a18729f46d454ba37b0a491fa98850abc31c3cc35a00b443f6cd40d3c2859b83f2c9d374db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fca86acce9a301362264ff4c85acf9aa4ea5035b84d5e0326716ac86389b85298df3dfe40ad8dd902779ce4d590c4b5077f2810b621efa03148790d5a3195f2c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e7a0861f1fa8dc629e76c7a6fa27a8bd6a5970564124d6809b695c143f803c00f503e13322637bf5970c7773a5bff5d25568e42fa548ebd5a6d17f18fa422de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fcc083eea3d945e00264a886138330534bd37ed6320b7f38b3b107adcb2fabca2747a2130d0c4a9741f572f9aa4ddaf5a0c4edb5f096f7d314cbf9d94b8e4f45"} 18:28:28 INFO - Running post-run listener: copy_logs_to_upload_dir 18:28:28 INFO - Copying logs to upload dir... 18:28:28 INFO - mkdir: /builds/slave/test/build/upload/logs 18:28:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.800655 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-07-07 18:28:28.007100) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-07 18:28:28.015984) ========= 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=af724c981e2a0f424dbabf99000001e7-1499461178.923793-336966328 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/63cc6b8fd5595b4787120b5302c9af3c66d66aeca6aca24e5ae560a18729f46d454ba37b0a491fa98850abc31c3cc35a00b443f6cd40d3c2859b83f2c9d374db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fca86acce9a301362264ff4c85acf9aa4ea5035b84d5e0326716ac86389b85298df3dfe40ad8dd902779ce4d590c4b5077f2810b621efa03148790d5a3195f2c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e7a0861f1fa8dc629e76c7a6fa27a8bd6a5970564124d6809b695c143f803c00f503e13322637bf5970c7773a5bff5d25568e42fa548ebd5a6d17f18fa422de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fcc083eea3d945e00264a886138330534bd37ed6320b7f38b3b107adcb2fabca2747a2130d0c4a9741f572f9aa4ddaf5a0c4edb5f096f7d314cbf9d94b8e4f45"} build_url:https://queue.taskcluster.net/v1/task/D2rRP0iaRl-gLAoDs4K12Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011205 build_url: 'https://queue.taskcluster.net/v1/task/D2rRP0iaRl-gLAoDs4K12Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63cc6b8fd5595b4787120b5302c9af3c66d66aeca6aca24e5ae560a18729f46d454ba37b0a491fa98850abc31c3cc35a00b443f6cd40d3c2859b83f2c9d374db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fca86acce9a301362264ff4c85acf9aa4ea5035b84d5e0326716ac86389b85298df3dfe40ad8dd902779ce4d590c4b5077f2810b621efa03148790d5a3195f2c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e7a0861f1fa8dc629e76c7a6fa27a8bd6a5970564124d6809b695c143f803c00f503e13322637bf5970c7773a5bff5d25568e42fa548ebd5a6d17f18fa422de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fcc083eea3d945e00264a886138330534bd37ed6320b7f38b3b107adcb2fabca2747a2130d0c4a9741f572f9aa4ddaf5a0c4edb5f096f7d314cbf9d94b8e4f45"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-07 18:28:28.050655) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-07 18:28:28.051060) ========= 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=af724c981e2a0f424dbabf99000001e7-1499461178.923793-336966328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004420 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-07 18:28:28.124346) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-07 18:28:28.124688) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-07 18:28:28.125012) ========= ========= Total master_lag: 0.23 =========