builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-015 starttime: 1502944891.65 results: success (0) revision: 932388b8c22c9775264e543697ce918415db9e23 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 21:41:31.648861) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 21:41:31.649522) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 21:41:31.650652) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 21:41:31.682645) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 21:41:31.682927) ========= 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=20e666a3d4cfbb71505a330e000001b4-1502936562.113536-1093056980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-16 21:41:32-- 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% 26.9M=0s 2017-08-16 21:41:32 (26.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.082548 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 21:41:31.780691) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 21:41:31.784014) ========= 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=20e666a3d4cfbb71505a330e000001b4-1502936562.113536-1093056980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019237 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 21:41:31.841753) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-16 21:41:31.842078) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 932388b8c22c9775264e543697ce918415db9e23 --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 932388b8c22c9775264e543697ce918415db9e23 --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=20e666a3d4cfbb71505a330e000001b4-1502936562.113536-1093056980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-16 21:41:32,288 truncating revision to first 12 chars 2017-08-16 21:41:32,288 Setting DEBUG logging. 2017-08-16 21:41:32,288 attempt 1/10 2017-08-16 21:41:32,288 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/932388b8c22c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-16 21:41:33,282 unpacking tar archive at: mozilla-central-932388b8c22c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.303035 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-16 21:41:33.171582) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 21:41:33.171908) ========= script_repo_revision: 932388b8c22c9775264e543697ce918415db9e23 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 21:41:33.172325) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 21:41:33.172598) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 21:41:33.184365) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-08-16 21:41:33.184674) ========= /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=20e666a3d4cfbb71505a330e000001b4-1502936562.113536-1093056980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:41:33 INFO - MultiFileLogger online at 20170816 21:41:33 in /builds/slave/test 21:41:33 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 21:41:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:41:33 INFO - {'append_to_log': False, 21:41:33 INFO - 'base_work_dir': '/builds/slave/test', 21:41:33 INFO - 'blob_upload_branch': 'Firefox', 21:41:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:41:33 INFO - 'branch': 'Firefox', 21:41:33 INFO - 'buildbot_json_path': 'buildprops.json', 21:41:33 INFO - 'code_coverage': False, 21:41:33 INFO - 'config_files': ('talos/linux_config.py',), 21:41:33 INFO - 'default_actions': ('clobber', 21:41:33 INFO - 'read-buildbot-config', 21:41:33 INFO - 'download-and-extract', 21:41:33 INFO - 'populate-webroot', 21:41:33 INFO - 'create-virtualenv', 21:41:33 INFO - 'install', 21:41:33 INFO - 'setup-mitmproxy', 21:41:33 INFO - 'run-tests'), 21:41:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:41:33 INFO - 'disable_ccov_upload': False, 21:41:33 INFO - 'download_minidump_stackwalk': True, 21:41:33 INFO - 'download_symbols': 'ondemand', 21:41:33 INFO - 'enable_stylo': False, 21:41:33 INFO - 'enable_webrender': False, 21:41:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:41:33 INFO - 'tooltool.py': '/tools/tooltool.py', 21:41:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:41:33 INFO - '/tools/misc-python/virtualenv.py')}, 21:41:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:41:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:41:33 INFO - 'gecko_profile': False, 21:41:33 INFO - 'gecko_profile_interval': 0, 21:41:33 INFO - 'installer_path': 'installer.exe', 21:41:33 INFO - 'log_level': 'info', 21:41:33 INFO - 'log_name': 'talos', 21:41:33 INFO - 'log_to_console': True, 21:41:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:41:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:41:33 INFO - 'opt_config_files': (), 21:41:33 INFO - 'pip_index': False, 21:41:33 INFO - 'suite': 'dromaeojs-e10s', 21:41:33 INFO - 'system_bits': '32', 21:41:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:41:33 INFO - 'title': 'talos-linux64-ix-015', 21:41:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:41:33 INFO - 'use_talos_json': True, 21:41:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:41:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:41:33 INFO - 'work_dir': 'build'} 21:41:33 INFO - [mozharness: 2017-08-17 04:41:33.729923Z] Running clobber step. 21:41:33 INFO - Running pre-action listener: _resource_record_pre_action 21:41:33 INFO - Running main action method: clobber 21:41:33 INFO - rmtree: /builds/slave/test/build 21:41:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:41:35 INFO - Running post-action listener: _resource_record_post_action 21:41:35 INFO - [mozharness: 2017-08-17 04:41:35.267289Z] Finished clobber step (success) 21:41:35 INFO - [mozharness: 2017-08-17 04:41:35.267392Z] Running read-buildbot-config step. 21:41:35 INFO - Running pre-action listener: _resource_record_pre_action 21:41:35 INFO - Running main action method: read_buildbot_config 21:41:35 INFO - Using buildbot properties: 21:41:35 INFO - { 21:41:35 INFO - "project": "", 21:41:35 INFO - "product": "firefox", 21:41:35 INFO - "who": "philringnalda@gmail.com", 21:41:35 INFO - "installer_path": "public/build/target.tar.bz2", 21:41:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 21:41:35 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 21:41:35 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 21:41:35 INFO - "stage_platform": "linux64-qr", 21:41:35 INFO - "basedir": "/builds/slave/test", 21:41:35 INFO - "buildnumber": 5, 21:41:35 INFO - "platform": "ubuntu64_hw_qr", 21:41:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:41:35 INFO - "slavebuilddir": "test", 21:41:35 INFO - "taskId": "cgSCwrcxSyCGKMpIIw6PvA", 21:41:35 INFO - "branch": "mozilla-central", 21:41:35 INFO - "script_repo_revision": "production", 21:41:35 INFO - "revision": "932388b8c22c9775264e543697ce918415db9e23", 21:41:35 INFO - "slavename": "talos-linux64-ix-015", 21:41:35 INFO - "repo_path": "mozilla-central" 21:41:35 INFO - } 21:41:35 INFO - Finding installer, test and symbols from parent task. 21:41:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cgSCwrcxSyCGKMpIIw6PvA'}, attempt #1 21:41:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cgSCwrcxSyCGKMpIIw6PvA'}, attempt #1 21:41:37 INFO - Task dependencies: GAdvR_fzSk6gV6tKKcdXVg 21:41:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg'}, attempt #1 21:41:37 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.tar.bz2 21:41:37 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.test_packages.json 21:41:37 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.crashreporter-symbols.zip 21:41:37 INFO - Running post-action listener: _resource_record_post_action 21:41:37 INFO - [mozharness: 2017-08-17 04:41:37.630262Z] Finished read-buildbot-config step (success) 21:41:37 INFO - [mozharness: 2017-08-17 04:41:37.630490Z] Running download-and-extract step. 21:41:37 INFO - Running pre-action listener: _resource_record_pre_action 21:41:37 INFO - Running main action method: download_and_extract 21:41:37 INFO - mkdir: /builds/slave/test/build/tests 21:41:37 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')]} 21:41:37 INFO - trying https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.test_packages.json 21:41:37 INFO - Downloading https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 21:41:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 21:41:38 INFO - Downloaded 989 bytes. 21:41:38 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 21:41:38 INFO - Using the following test package requirements: 21:41:38 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 21:41:38 INFO - u'common': [u'target.common.tests.zip'], 21:41:38 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 21:41:38 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 21:41:38 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 21:41:38 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 21:41:38 INFO - u'mozbase': [u'target.common.tests.zip'], 21:41:38 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 21:41:38 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 21:41:38 INFO - u'web-platform': [u'target.common.tests.zip', 21:41:38 INFO - u'target.web-platform.tests.tar.gz'], 21:41:38 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 21:41:38 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 21:41:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.common.tests.zip 21:41:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:41:38 INFO - Fetch https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.common.tests.zip into memory 21:41:39 INFO - Content-Length response header: 53999257 21:41:39 INFO - Bytes received: 53999257 21:41:50 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 21:41:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.common.tests.zip 21:41:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:41:50 INFO - Fetch https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.common.tests.zip into memory 21:41:51 INFO - Content-Length response header: 53999257 21:41:51 INFO - Bytes received: 53999257 21:42:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.talos.tests.zip 21:42:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 21:42:03 INFO - Fetch https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.talos.tests.zip into memory 21:42:03 INFO - Content-Length response header: 14496161 21:42:03 INFO - Bytes received: 14496161 21:42:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:04 INFO - trying https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.tar.bz2 21:42:04 INFO - Downloading https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 21:42:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 21:42:05 INFO - Downloaded 61823178 bytes. 21:42:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.tar.bz2 21:42:05 INFO - mkdir: /builds/slave/test/properties 21:42:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:42:05 INFO - Writing to file /builds/slave/test/properties/build_url 21:42:05 INFO - Contents: 21:42:05 INFO - build_url:https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.tar.bz2 21:42:05 INFO - Running post-action listener: _resource_record_post_action 21:42:05 INFO - Running post-action listener: set_extra_try_arguments 21:42:05 INFO - [mozharness: 2017-08-17 04:42:05.166410Z] Finished download-and-extract step (success) 21:42:05 INFO - [mozharness: 2017-08-17 04:42:05.166510Z] Running populate-webroot step. 21:42:05 INFO - Running pre-action listener: _resource_record_pre_action 21:42:05 INFO - Running main action method: populate_webroot 21:42:05 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:42:05 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 21:42:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:42:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:42:05 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 21:42:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:42:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:42:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:42:05 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 21:42:05 INFO - 'talos_options': ['--stylo'], 21:42:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:42:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:42:05 INFO - 'tests': ['damp', 'tps']}, 21:42:05 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 21:42:05 INFO - 'talos_options': ['--stylo'], 21:42:05 INFO - 'tests': ['damp', 'tps']}, 21:42:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:42:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 21:42:05 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 21:42:05 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 21:42:05 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 21:42:05 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 21:42:05 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 21:42:05 INFO - 'talos_options': ['--stylo'], 21:42:05 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 21:42:05 INFO - 'other-e10s': {'tests': ['a11yr', 21:42:05 INFO - 'ts_paint', 21:42:05 INFO - 'tpaint', 21:42:05 INFO - 'sessionrestore', 21:42:05 INFO - 'sessionrestore_many_windows', 21:42:05 INFO - 'sessionrestore_no_auto_restore', 21:42:05 INFO - 'tabpaint']}, 21:42:05 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 21:42:05 INFO - 'tests': ['a11yr', 21:42:05 INFO - 'ts_paint', 21:42:05 INFO - 'tpaint', 21:42:05 INFO - 'sessionrestore', 21:42:05 INFO - 'sessionrestore_many_windows', 21:42:05 INFO - 'sessionrestore_no_auto_restore', 21:42:05 INFO - 'tabpaint']}, 21:42:05 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 21:42:05 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 21:42:05 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 21:42:05 INFO - 'tests': ['bloom_basic_singleton']}, 21:42:05 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 21:42:05 INFO - 'tests': ['bloom_basic']}, 21:42:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:42:05 INFO - 'tsvgr_opacity', 21:42:05 INFO - 'tart', 21:42:05 INFO - 'tscrollx', 21:42:05 INFO - 'tsvg_static']}, 21:42:05 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 21:42:05 INFO - 'tests': ['tsvgx', 21:42:05 INFO - 'tsvgr_opacity', 21:42:05 INFO - 'tart', 21:42:05 INFO - 'tscrollx', 21:42:05 INFO - 'tsvg_static']}, 21:42:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:42:05 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 21:42:05 INFO - 'talos_options': ['--stylo'], 21:42:05 INFO - 'tests': ['tp5o']}, 21:42:05 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 21:42:05 INFO - 'talos_options': ['--mitmproxy', 21:42:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 21:42:05 INFO - '--firstNonBlankPaint'], 21:42:05 INFO - 'tests': ['tp6_google', 21:42:05 INFO - 'tp6_youtube', 21:42:05 INFO - 'tp6_amazon', 21:42:05 INFO - 'tp6_facebook']}, 21:42:05 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 21:42:05 INFO - 'talos_options': ['--stylo', 21:42:05 INFO - '--mitmproxy', 21:42:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 21:42:05 INFO - '--firstNonBlankPaint'], 21:42:05 INFO - 'tests': ['tp6_google', 21:42:05 INFO - 'tp6_youtube', 21:42:05 INFO - 'tp6_amazon', 21:42:05 INFO - 'tp6_facebook']}, 21:42:05 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 21:42:05 INFO - 'talos_options': ['--stylo', 21:42:05 INFO - '--stylo-threads=1', 21:42:05 INFO - '--mitmproxy', 21:42:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 21:42:05 INFO - '--firstNonBlankPaint'], 21:42:05 INFO - 'tests': ['tp6_google', 21:42:05 INFO - 'tp6_youtube', 21:42:05 INFO - 'tp6_amazon', 21:42:05 INFO - 'tp6_facebook']}, 21:42:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:42:05 INFO - 'talos_options': ['--xperf_path', 21:42:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:42:05 INFO - 'tests': ['tp5n']}, 21:42:05 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 21:42:05 INFO - 'talos_options': ['--stylo', 21:42:05 INFO - '--xperf_path', 21:42:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:42:05 INFO - 'tests': ['tp5n']}}} 21:42:05 INFO - Running post-action listener: _resource_record_post_action 21:42:05 INFO - [mozharness: 2017-08-17 04:42:05.180906Z] Finished populate-webroot step (success) 21:42:05 INFO - [mozharness: 2017-08-17 04:42:05.180998Z] Running create-virtualenv step. 21:42:05 INFO - Running pre-action listener: _resource_record_pre_action 21:42:05 INFO - Running main action method: create_virtualenv 21:42:05 INFO - Creating virtualenv /builds/slave/test/build/venv 21:42: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 21:42:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:42:05 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 21:42:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:42:05 INFO - Using real prefix '/usr' 21:42:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:42:05 INFO - Installing distribute.............................................................................................................................................................................................done. 21:42:07 INFO - Installing pip.................done. 21:42:07 INFO - Return code: 0 21:42:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:42:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:42:07 INFO - Reading from file tmpfile_stdout 21:42:07 INFO - Output received: 21:42:07 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) 21:42:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:42:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42: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 0x1bd41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e790b0>, '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 0x1e79fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7a440>, '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': '20e666a3d4cfbb71505a330e000001b4-1502936562.113536-1093056980', '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 21:42: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 21:42: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 21:42:08 INFO - Using env: {'DISPLAY': ':0', 21:42:08 INFO - 'HOME': '/home/cltbld', 21:42:08 INFO - 'LANG': 'en_US.UTF-8', 21:42:08 INFO - 'LANGUAGE': 'en_US:en', 21:42:08 INFO - 'LOGNAME': 'cltbld', 21:42:08 INFO - 'MAIL': '/var/mail/cltbld', 21:42:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:08 INFO - 'MOZ_NO_REMOTE': '1', 21:42:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:08 INFO - 'NO_EM_RESTART': '1', 21:42:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:08 INFO - 'PWD': '/builds/slave/test', 21:42:08 INFO - 'SHELL': '/bin/bash', 21:42:08 INFO - 'SHLVL': '1', 21:42:08 INFO - 'TERM': 'linux', 21:42:08 INFO - 'TMOUT': '86400', 21:42:08 INFO - 'USER': 'cltbld', 21:42:08 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1502936562.113536-1093056980', 21:42:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:08 INFO - '_': '/tools/buildbot/bin/python'} 21:42:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:08 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 21:42:08 INFO - Cleaning up... 21:42:08 INFO - Return code: 0 21:42:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:42: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')]} 21:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42: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')]} 21:42:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42: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', '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 0x1bd41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e790b0>, '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 0x1e79fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7a440>, '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': '20e666a3d4cfbb71505a330e000001b4-1502936562.113536-1093056980', '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 21:42: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', 'psutil>=3.1.1'] in /builds/slave/test/build 21:42: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 psutil>=3.1.1 21:42:08 INFO - Using env: {'DISPLAY': ':0', 21:42:08 INFO - 'HOME': '/home/cltbld', 21:42:08 INFO - 'LANG': 'en_US.UTF-8', 21:42:08 INFO - 'LANGUAGE': 'en_US:en', 21:42:08 INFO - 'LOGNAME': 'cltbld', 21:42:08 INFO - 'MAIL': '/var/mail/cltbld', 21:42:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:08 INFO - 'MOZ_NO_REMOTE': '1', 21:42:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:08 INFO - 'NO_EM_RESTART': '1', 21:42:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:08 INFO - 'PWD': '/builds/slave/test', 21:42:08 INFO - 'SHELL': '/bin/bash', 21:42:08 INFO - 'SHLVL': '1', 21:42:08 INFO - 'TERM': 'linux', 21:42:08 INFO - 'TMOUT': '86400', 21:42:08 INFO - 'USER': 'cltbld', 21:42:08 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1502936562.113536-1093056980', 21:42:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:08 INFO - '_': '/tools/buildbot/bin/python'} 21:42:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:08 INFO - Downloading/unpacking psutil>=3.1.1 21:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:42:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:42:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:42:09 INFO - Installing collected packages: psutil 21:42:09 INFO - Running setup.py install for psutil 21:42:09 INFO - building 'psutil._psutil_linux' extension 21:42:09 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 21:42:09 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 21:42:09 INFO - building 'psutil._psutil_posix' extension 21:42:09 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 21:42: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 21:42:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:42:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:42:10 INFO - Successfully installed psutil 21:42:10 INFO - Cleaning up... 21:42:10 INFO - Return code: 0 21:42:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:42:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e790b0>, '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 0x1e79fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7a440>, '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': '20e666a3d4cfbb71505a330e000001b4-1502936562.113536-1093056980', '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 21:42:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:42:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:42:10 INFO - Using env: {'DISPLAY': ':0', 21:42:10 INFO - 'HOME': '/home/cltbld', 21:42:10 INFO - 'LANG': 'en_US.UTF-8', 21:42:10 INFO - 'LANGUAGE': 'en_US:en', 21:42:10 INFO - 'LOGNAME': 'cltbld', 21:42:10 INFO - 'MAIL': '/var/mail/cltbld', 21:42:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:10 INFO - 'MOZ_NO_REMOTE': '1', 21:42:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:10 INFO - 'NO_EM_RESTART': '1', 21:42:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:10 INFO - 'PWD': '/builds/slave/test', 21:42:10 INFO - 'SHELL': '/bin/bash', 21:42:10 INFO - 'SHLVL': '1', 21:42:10 INFO - 'TERM': 'linux', 21:42:10 INFO - 'TMOUT': '86400', 21:42:10 INFO - 'USER': 'cltbld', 21:42:10 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1502936562.113536-1093056980', 21:42:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:10 INFO - '_': '/tools/buildbot/bin/python'} 21:42:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:42:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:42:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:42:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:42:11 INFO - Installing collected packages: mozsystemmonitor 21:42:11 INFO - Running setup.py install for mozsystemmonitor 21:42:11 INFO - Successfully installed mozsystemmonitor 21:42:11 INFO - Cleaning up... 21:42:11 INFO - Return code: 0 21:42:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:42: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')]} 21:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42: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')]} 21:42:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42: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', '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 0x1bd41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e790b0>, '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 0x1e79fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7a440>, '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': '20e666a3d4cfbb71505a330e000001b4-1502936562.113536-1093056980', '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 21:42: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:42: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 jsonschema==2.5.1 21:42:11 INFO - Using env: {'DISPLAY': ':0', 21:42:11 INFO - 'HOME': '/home/cltbld', 21:42:11 INFO - 'LANG': 'en_US.UTF-8', 21:42:11 INFO - 'LANGUAGE': 'en_US:en', 21:42:11 INFO - 'LOGNAME': 'cltbld', 21:42:11 INFO - 'MAIL': '/var/mail/cltbld', 21:42:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:11 INFO - 'MOZ_NO_REMOTE': '1', 21:42:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:11 INFO - 'NO_EM_RESTART': '1', 21:42:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:11 INFO - 'PWD': '/builds/slave/test', 21:42:11 INFO - 'SHELL': '/bin/bash', 21:42:11 INFO - 'SHLVL': '1', 21:42:11 INFO - 'TERM': 'linux', 21:42:11 INFO - 'TMOUT': '86400', 21:42:11 INFO - 'USER': 'cltbld', 21:42:11 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1502936562.113536-1093056980', 21:42:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:11 INFO - '_': '/tools/buildbot/bin/python'} 21:42:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:11 INFO - Downloading/unpacking jsonschema==2.5.1 21:42: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 21:42: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 21:42: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 21:42: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 21:42:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:42:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:42: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 21:42: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 21:42: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 21:42: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 21:42:13 INFO - Downloading functools32-3.2.3-2.tar.gz 21:42:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:42:13 INFO - warning: no files found matching '*.txt' 21:42:13 INFO - no previously-included directories found matching 'build' 21:42:13 INFO - no previously-included directories found matching 'dist' 21:42:13 INFO - no previously-included directories found matching '.git*' 21:42:13 INFO - Installing collected packages: jsonschema, functools32 21:42:13 INFO - Running setup.py install for functools32 21:42:13 INFO - warning: no files found matching '*.txt' 21:42:13 INFO - no previously-included directories found matching 'build' 21:42:13 INFO - no previously-included directories found matching 'dist' 21:42:13 INFO - no previously-included directories found matching '.git*' 21:42:13 INFO - Successfully installed jsonschema functools32 21:42:13 INFO - Cleaning up... 21:42:13 INFO - Return code: 0 21:42:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:42:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1bd41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e790b0>, '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 0x1e79fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7a440>, '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': '20e666a3d4cfbb71505a330e000001b4-1502936562.113536-1093056980', '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 21:42:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:42:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:42:13 INFO - Using env: {'DISPLAY': ':0', 21:42:13 INFO - 'HOME': '/home/cltbld', 21:42:13 INFO - 'LANG': 'en_US.UTF-8', 21:42:13 INFO - 'LANGUAGE': 'en_US:en', 21:42:13 INFO - 'LOGNAME': 'cltbld', 21:42:13 INFO - 'MAIL': '/var/mail/cltbld', 21:42:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:13 INFO - 'MOZ_NO_REMOTE': '1', 21:42:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:13 INFO - 'NO_EM_RESTART': '1', 21:42:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:13 INFO - 'PWD': '/builds/slave/test', 21:42:13 INFO - 'SHELL': '/bin/bash', 21:42:13 INFO - 'SHLVL': '1', 21:42:13 INFO - 'TERM': 'linux', 21:42:13 INFO - 'TMOUT': '86400', 21:42:13 INFO - 'USER': 'cltbld', 21:42:13 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1502936562.113536-1093056980', 21:42:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:13 INFO - '_': '/tools/buildbot/bin/python'} 21:42:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:42:13 INFO - Cleaning up... 21:42:13 INFO - Return code: 0 21:42:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:42:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1bd41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e790b0>, '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 0x1e79fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7a440>, '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': '20e666a3d4cfbb71505a330e000001b4-1502936562.113536-1093056980', '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 21:42:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:42:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:42:13 INFO - Using env: {'DISPLAY': ':0', 21:42:13 INFO - 'HOME': '/home/cltbld', 21:42:13 INFO - 'LANG': 'en_US.UTF-8', 21:42:13 INFO - 'LANGUAGE': 'en_US:en', 21:42:13 INFO - 'LOGNAME': 'cltbld', 21:42:13 INFO - 'MAIL': '/var/mail/cltbld', 21:42:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:13 INFO - 'MOZ_NO_REMOTE': '1', 21:42:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:13 INFO - 'NO_EM_RESTART': '1', 21:42:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:13 INFO - 'PWD': '/builds/slave/test', 21:42:13 INFO - 'SHELL': '/bin/bash', 21:42:13 INFO - 'SHLVL': '1', 21:42:13 INFO - 'TERM': 'linux', 21:42:13 INFO - 'TMOUT': '86400', 21:42:13 INFO - 'USER': 'cltbld', 21:42:13 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1502936562.113536-1093056980', 21:42:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:13 INFO - '_': '/tools/buildbot/bin/python'} 21:42:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:13 INFO - Downloading/unpacking blobuploader==1.2.4 21:42: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 21:42: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 21:42: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 21:42: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 21:42:14 INFO - Downloading blobuploader-1.2.4.tar.gz 21:42:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:42:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:42: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 21:42: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 21:42: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 21:42: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 21:42:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:42:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:42: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 21:42: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 21:42: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 21:42: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 21:42:15 INFO - Downloading docopt-0.6.1.tar.gz 21:42:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:42:15 INFO - Installing collected packages: blobuploader, requests, docopt 21:42:15 INFO - Running setup.py install for blobuploader 21:42:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:42:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:42:15 INFO - Running setup.py install for requests 21:42:15 INFO - Running setup.py install for docopt 21:42:16 INFO - Successfully installed blobuploader requests docopt 21:42:16 INFO - Cleaning up... 21:42:16 INFO - Return code: 0 21:42:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:42: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')]} 21:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42: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')]} 21:42:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42: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 0x1bd41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e790b0>, '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 0x1e79fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7a440>, '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': '20e666a3d4cfbb71505a330e000001b4-1502936562.113536-1093056980', '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 21:42: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 21:42: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 21:42:16 INFO - Using env: {'DISPLAY': ':0', 21:42:16 INFO - 'HOME': '/home/cltbld', 21:42:16 INFO - 'LANG': 'en_US.UTF-8', 21:42:16 INFO - 'LANGUAGE': 'en_US:en', 21:42:16 INFO - 'LOGNAME': 'cltbld', 21:42:16 INFO - 'MAIL': '/var/mail/cltbld', 21:42:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:16 INFO - 'MOZ_NO_REMOTE': '1', 21:42:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:16 INFO - 'NO_EM_RESTART': '1', 21:42:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:16 INFO - 'PWD': '/builds/slave/test', 21:42:16 INFO - 'SHELL': '/bin/bash', 21:42:16 INFO - 'SHLVL': '1', 21:42:16 INFO - 'TERM': 'linux', 21:42:16 INFO - 'TMOUT': '86400', 21:42:16 INFO - 'USER': 'cltbld', 21:42:16 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1502936562.113536-1093056980', 21:42:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:16 INFO - '_': '/tools/buildbot/bin/python'} 21:42:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:42:16 INFO - Running setup.py (path:/tmp/pip-Xy9kWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:42:16 INFO - Running setup.py (path:/tmp/pip-9dNbth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:42:16 INFO - Running setup.py (path:/tmp/pip-GXgHAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:42:16 INFO - Running setup.py (path:/tmp/pip-T6PUgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:42:16 INFO - Running setup.py (path:/tmp/pip-NaKblN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:42:16 INFO - Running setup.py (path:/tmp/pip-y5SSk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:42:16 INFO - Running setup.py (path:/tmp/pip-mKGB1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:42:16 INFO - Running setup.py (path:/tmp/pip-X5m2Uz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:42:16 INFO - Running setup.py (path:/tmp/pip-6db6yL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:42:16 INFO - Running setup.py (path:/tmp/pip-3DaZRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:42:17 INFO - Running setup.py (path:/tmp/pip-t7rBRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:42:17 INFO - Running setup.py (path:/tmp/pip-ownPnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:42:17 INFO - Running setup.py (path:/tmp/pip-ilS1RN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:42:17 INFO - Running setup.py (path:/tmp/pip-FCah6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:42:17 INFO - Running setup.py (path:/tmp/pip-6uxk49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:42:17 INFO - Running setup.py (path:/tmp/pip-j6Bq_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:42:17 INFO - Running setup.py (path:/tmp/pip-XUH0VU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:42:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:42:17 INFO - Running setup.py install for manifestparser 21:42:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:42:17 INFO - Running setup.py install for mozcrash 21:42:17 INFO - Running setup.py install for mozdebug 21:42:17 INFO - Running setup.py install for mozdevice 21:42:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:42:17 INFO - Running setup.py install for mozfile 21:42:18 INFO - Running setup.py install for mozhttpd 21:42:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:42:18 INFO - Running setup.py install for mozinfo 21:42:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:42:18 INFO - Running setup.py install for mozInstall 21:42:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:42:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:42:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:42:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:42:18 INFO - Running setup.py install for mozleak 21:42:18 INFO - Running setup.py install for mozlog 21:42:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:42:18 INFO - Running setup.py install for moznetwork 21:42:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:42:18 INFO - Running setup.py install for mozprocess 21:42:18 INFO - Running setup.py install for mozprofile 21:42:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:42:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:42:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:42:18 INFO - Running setup.py install for mozrunner 21:42:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:42:19 INFO - Running setup.py install for mozscreenshot 21:42:19 INFO - Running setup.py install for moztest 21:42:19 INFO - Running setup.py install for mozversion 21:42:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:42:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:42:19 INFO - Cleaning up... 21:42:19 INFO - Return code: 0 21:42:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:42:19 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')]} 21:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:19 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')]} 21:42:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:19 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 0x1bd41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e790b0>, '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 0x1e79fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7a440>, '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': '20e666a3d4cfbb71505a330e000001b4-1502936562.113536-1093056980', '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 21:42:19 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 21:42:19 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 21:42:19 INFO - Using env: {'DISPLAY': ':0', 21:42:19 INFO - 'HOME': '/home/cltbld', 21:42:19 INFO - 'LANG': 'en_US.UTF-8', 21:42:19 INFO - 'LANGUAGE': 'en_US:en', 21:42:19 INFO - 'LOGNAME': 'cltbld', 21:42:19 INFO - 'MAIL': '/var/mail/cltbld', 21:42:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:19 INFO - 'MOZ_NO_REMOTE': '1', 21:42:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:19 INFO - 'NO_EM_RESTART': '1', 21:42:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:19 INFO - 'PWD': '/builds/slave/test', 21:42:19 INFO - 'SHELL': '/bin/bash', 21:42:19 INFO - 'SHLVL': '1', 21:42:19 INFO - 'TERM': 'linux', 21:42:19 INFO - 'TMOUT': '86400', 21:42:19 INFO - 'USER': 'cltbld', 21:42:19 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1502936562.113536-1093056980', 21:42:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:19 INFO - '_': '/tools/buildbot/bin/python'} 21:42:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:42:19 INFO - Running setup.py (path:/tmp/pip-7uI8CT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:42:19 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)) 21:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:42:19 INFO - Running setup.py (path:/tmp/pip-yk9xeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:42:19 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)) 21:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:42:19 INFO - Running setup.py (path:/tmp/pip-9Cs_iv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:42:19 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)) 21:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:42:19 INFO - Running setup.py (path:/tmp/pip-fLoZAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:42:19 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)) 21:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:42:19 INFO - Running setup.py (path:/tmp/pip-IEHDZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:42:19 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)) 21:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:42:19 INFO - Running setup.py (path:/tmp/pip-y4hM0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:42:19 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)) 21:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:42:19 INFO - Running setup.py (path:/tmp/pip-I1L98A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:42: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)) 21:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:42:20 INFO - Running setup.py (path:/tmp/pip-NEhUf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:42: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)) 21:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:42:20 INFO - Running setup.py (path:/tmp/pip-Wl2eV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:42: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)) 21:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:42:20 INFO - Running setup.py (path:/tmp/pip-w5x3Uj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:42:20 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)) 21:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:42:20 INFO - Running setup.py (path:/tmp/pip-MYJIIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:42:20 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)) 21:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:42:20 INFO - Running setup.py (path:/tmp/pip-sY44gX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:42:20 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)) 21:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:42:20 INFO - Running setup.py (path:/tmp/pip-x5YUGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:42:20 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)) 21:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:42:20 INFO - Running setup.py (path:/tmp/pip-j7oSyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:42:20 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)) 21:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:42:20 INFO - Running setup.py (path:/tmp/pip-JnuWA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:42:20 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)) 21:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:42:20 INFO - Running setup.py (path:/tmp/pip-gHthOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:42:20 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)) 21:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:42:20 INFO - Running setup.py (path:/tmp/pip-M6CZcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:42:20 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)) 21:42:20 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)) 21:42:20 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)) 21:42:20 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)) 21:42:20 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)) 21:42:20 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)) 21:42:20 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)) 21:42:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:21 INFO - Downloading blessings-1.6.tar.gz 21:42:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:42:21 INFO - Installing collected packages: blessings 21:42:21 INFO - Running setup.py install for blessings 21:42:22 INFO - Successfully installed blessings 21:42:22 INFO - Cleaning up... 21:42:22 INFO - Return code: 0 21:42:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:42:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:42:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:42:22 INFO - Reading from file tmpfile_stdout 21:42:22 INFO - Current package versions: 21:42:22 INFO - argparse == 1.2.1 21:42:22 INFO - blessings == 1.6 21:42:22 INFO - blobuploader == 1.2.4 21:42:22 INFO - docopt == 0.6.1 21:42:22 INFO - functools32 == 3.2.3-2 21:42:22 INFO - jsonschema == 2.5.1 21:42:22 INFO - manifestparser == 1.1 21:42:22 INFO - mozInstall == 1.13 21:42:22 INFO - mozcrash == 1.0 21:42:22 INFO - mozdebug == 0.1 21:42:22 INFO - mozdevice == 0.51 21:42:22 INFO - mozfile == 1.2 21:42:22 INFO - mozhttpd == 0.7 21:42:22 INFO - mozinfo == 0.10 21:42:22 INFO - mozleak == 0.1 21:42:22 INFO - mozlog == 3.5 21:42:22 INFO - moznetwork == 0.27 21:42:22 INFO - mozprocess == 0.25 21:42:22 INFO - mozprofile == 0.28 21:42:22 INFO - mozrunner == 6.13 21:42:22 INFO - mozscreenshot == 0.1 21:42:22 INFO - mozsystemmonitor == 0.3 21:42:22 INFO - moztest == 0.8 21:42:22 INFO - mozversion == 1.4 21:42:22 INFO - psutil == 3.1.1 21:42:22 INFO - requests == 1.2.3 21:42:22 INFO - wsgiref == 0.1.2 21:42:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:22 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 0x1bd41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e790b0>, '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 0x1e79fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7a440>, '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': '20e666a3d4cfbb71505a330e000001b4-1502936562.113536-1093056980', '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 21:42:22 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 21:42:22 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 21:42:22 INFO - Using env: {'DISPLAY': ':0', 21:42:22 INFO - 'HOME': '/home/cltbld', 21:42:22 INFO - 'LANG': 'en_US.UTF-8', 21:42:22 INFO - 'LANGUAGE': 'en_US:en', 21:42:22 INFO - 'LOGNAME': 'cltbld', 21:42:22 INFO - 'MAIL': '/var/mail/cltbld', 21:42:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:22 INFO - 'MOZ_NO_REMOTE': '1', 21:42:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:22 INFO - 'NO_EM_RESTART': '1', 21:42:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:22 INFO - 'PWD': '/builds/slave/test', 21:42:22 INFO - 'SHELL': '/bin/bash', 21:42:22 INFO - 'SHLVL': '1', 21:42:22 INFO - 'TERM': 'linux', 21:42:22 INFO - 'TMOUT': '86400', 21:42:22 INFO - 'USER': 'cltbld', 21:42:22 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1502936562.113536-1093056980', 21:42:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:22 INFO - '_': '/tools/buildbot/bin/python'} 21:42:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:22 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)) 21:42:22 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)) 21:42:22 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)) 21:42:22 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)) 21:42:22 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)) 21:42:22 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)) 21:42:22 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)) 21:42:22 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)) 21:42:22 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)) 21:42:22 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 21:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 21:42:23 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)) 21:42:23 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)) 21:42:23 INFO - Installing collected packages: simplejson 21:42:23 INFO - Running setup.py install for simplejson 21:42:23 INFO - building 'simplejson._speedups' extension 21:42:23 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 21:42:24 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 21:42:24 INFO - Successfully installed simplejson 21:42:24 INFO - Cleaning up... 21:42:24 INFO - Return code: 0 21:42:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:42:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:24 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 0x1bd41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e790b0>, '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 0x1e79fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7a440>, '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': '20e666a3d4cfbb71505a330e000001b4-1502936562.113536-1093056980', '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 21:42:24 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 21:42:24 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 21:42:24 INFO - Using env: {'DISPLAY': ':0', 21:42:24 INFO - 'HOME': '/home/cltbld', 21:42:24 INFO - 'LANG': 'en_US.UTF-8', 21:42:24 INFO - 'LANGUAGE': 'en_US:en', 21:42:24 INFO - 'LOGNAME': 'cltbld', 21:42:24 INFO - 'MAIL': '/var/mail/cltbld', 21:42:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:24 INFO - 'MOZ_NO_REMOTE': '1', 21:42:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:24 INFO - 'NO_EM_RESTART': '1', 21:42:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:24 INFO - 'PWD': '/builds/slave/test', 21:42:24 INFO - 'SHELL': '/bin/bash', 21:42:24 INFO - 'SHLVL': '1', 21:42:24 INFO - 'TERM': 'linux', 21:42:24 INFO - 'TMOUT': '86400', 21:42:24 INFO - 'USER': 'cltbld', 21:42:24 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1502936562.113536-1093056980', 21:42:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:24 INFO - '_': '/tools/buildbot/bin/python'} 21:42:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:42:25 INFO - Cleaning up... 21:42:25 INFO - Return code: 0 21:42:25 INFO - Running post-action listener: _resource_record_post_action 21:42:25 INFO - Running post-action listener: _start_resource_monitoring 21:42:25 INFO - Starting resource monitoring. 21:42:25 INFO - [mozharness: 2017-08-17 04:42:25.072080Z] Finished create-virtualenv step (success) 21:42:25 INFO - [mozharness: 2017-08-17 04:42:25.072561Z] Running install step. 21:42:25 INFO - Running pre-action listener: _resource_record_pre_action 21:42:25 INFO - Running main action method: install 21:42:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:42:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:42:25 INFO - Reading from file tmpfile_stdout 21:42:25 INFO - Detecting whether we're running mozinstall >=1.0... 21:42:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:42:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:42:25 INFO - Reading from file tmpfile_stdout 21:42:25 INFO - Output received: 21:42:25 INFO - Usage: mozinstall [options] installer 21:42:25 INFO - Options: 21:42:25 INFO - -h, --help show this help message and exit 21:42:25 INFO - -d DEST, --destination=DEST 21:42:25 INFO - Directory to install application into. [default: 21:42:25 INFO - "/builds/slave/test"] 21:42:25 INFO - --app=APP Application being installed. [default: firefox] 21:42:25 INFO - mkdir: /builds/slave/test/build/application 21:42:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:42:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 21:42:43 INFO - Reading from file tmpfile_stdout 21:42:43 INFO - Output received: 21:42:43 INFO - /builds/slave/test/build/application/firefox/firefox 21:42:43 INFO - Running post-action listener: _resource_record_post_action 21:42:43 INFO - [mozharness: 2017-08-17 04:42:43.345884Z] Finished install step (success) 21:42:43 INFO - [mozharness: 2017-08-17 04:42:43.346143Z] Running setup-mitmproxy step. 21:42:43 INFO - Running pre-action listener: _resource_record_pre_action 21:42:43 INFO - Running main action method: setup_mitmproxy 21:42:43 INFO - Skipping: mitmproxy is not required 21:42:43 INFO - Running post-action listener: _resource_record_post_action 21:42:43 INFO - [mozharness: 2017-08-17 04:42:43.347313Z] Finished setup-mitmproxy step (success) 21:42:43 INFO - [mozharness: 2017-08-17 04:42:43.347537Z] Running run-tests step. 21:42:43 INFO - Running pre-action listener: _resource_record_pre_action 21:42:43 INFO - Running pre-action listener: _set_gcov_prefix 21:42:43 INFO - Running main action method: run_tests 21:42:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:42:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:42:43 INFO - Python 2.7.3 21:42:43 INFO - Return code: 0 21:42:43 INFO - grabbing minidump binary from tooltool 21:42:43 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')]} 21:42:43 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 0x1e790b0>, '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 0x1e79fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7a440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:42:43 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 21:42:43 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 21:42:43 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 21:42:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:42:43 INFO - Return code: 0 21:42:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:42:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:42:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:42:43 INFO - ENV: RUST_BACKTRACE is now full 21:42:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:42:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:42:43 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/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 21:42:43 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/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 21:42:43 INFO - Using env: {'DISPLAY': ':0', 21:42:43 INFO - 'HOME': '/home/cltbld', 21:42:43 INFO - 'LANG': 'en_US.UTF-8', 21:42:43 INFO - 'LANGUAGE': 'en_US:en', 21:42:43 INFO - 'LOGNAME': 'cltbld', 21:42:43 INFO - 'MAIL': '/var/mail/cltbld', 21:42:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:42:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:42:43 INFO - 'MOZ_ACCELERATED': '1', 21:42:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:43 INFO - 'MOZ_NO_REMOTE': '1', 21:42:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:42:43 INFO - 'MOZ_WEBRENDER': '1', 21:42:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:43 INFO - 'NO_EM_RESTART': '1', 21:42:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:43 INFO - 'PWD': '/builds/slave/test', 21:42:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:42:43 INFO - 'RUST_BACKTRACE': 'full', 21:42:43 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 21:42:43 INFO - 'SHELL': '/bin/bash', 21:42:43 INFO - 'SHLVL': '1', 21:42:43 INFO - 'TERM': 'linux', 21:42:43 INFO - 'TMOUT': '86400', 21:42:43 INFO - 'USER': 'cltbld', 21:42:43 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1502936562.113536-1093056980', 21:42:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:43 INFO - '_': '/tools/buildbot/bin/python'} 21:42:43 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/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 21:42:43 INFO - mozversion application_buildid: 20170817035831 21:42:43 INFO - mozversion application_changeset: 932388b8c22c9775264e543697ce918415db9e23 21:42:43 INFO - mozversion application_display_name: Nightly 21:42:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:42:43 INFO - mozversion application_name: Firefox 21:42:43 INFO - mozversion application_remotingname: firefox 21:42:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:42:43 INFO - mozversion application_vendor: Mozilla 21:42:43 INFO - mozversion application_version: 57.0a1 21:42:43 INFO - mozversion platform_buildid: 20170817035831 21:42:43 INFO - mozversion platform_changeset: 932388b8c22c9775264e543697ce918415db9e23 21:42:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:42:43 INFO - mozversion platform_version: 57.0a1 21:42:43 INFO - using testdate: 1502944963 21:42:43 INFO - actual date: 1502944963 21:42:43 INFO - starting webserver on 'localhost:57878' 21:42:43 INFO - SUITE-START | Running 2 tests 21:42:43 INFO - TEST-START | dromaeo_css 21:42:43 INFO - Initialising browser for dromaeo_css test... 21:42:43 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57878/getInfo.html -profile /tmp/tmpt1nLXC/profile 21:42:43 INFO - TEST-INFO | started process 25926 (/builds/slave/test/build/application/firefox/firefox http://localhost:57878/getInfo.html) 21:42:49 INFO - TEST-INFO | 25926: exit 0 21:42:49 INFO - Browser initialized. 21:42:49 INFO - Running cycle 1/1 for dromaeo_css test... 21:42:49 INFO - TEST-INFO | started process 26108 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt1nLXC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 21:42:50 INFO - PID 26108 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 21:42:51 INFO - PID 26108 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 21:42:51 INFO - PID 26108 | 21:42:51 INFO - PID 26108 | (/builds/slave/test/build/application/firefox/firefox:26165): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 21:42:51 INFO - PID 26108 | 21:43:01 INFO - PID 26108 | RSS: Main: 194048000 21:43:01 INFO - PID 26108 | 21:43:05 INFO - PID 26108 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 21:46:01 INFO - PID 26108 | Cycle 1(1): loaded http://localhost:57878/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57878/tests/dromaeo/cssquery-ext.html) 21:46:03 INFO - PID 26108 | RSS: Main: 223137792 21:46:03 INFO - PID 26108 | 21:49:05 INFO - PID 26108 | Cycle 1(1): loaded http://localhost:57878/tests/dromaeo/cssquery-ext.html (next: http://localhost:57878/tests/dromaeo/cssquery-jquery.html) 21:49:05 INFO - PID 26108 | RSS: Main: 268988416 21:49:05 INFO - PID 26108 | 21:52:07 INFO - PID 26108 | Cycle 1(1): loaded http://localhost:57878/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57878/tests/dromaeo/cssquery-mootools.html) 21:52:08 INFO - PID 26108 | RSS: Main: 273154048 21:52:08 INFO - PID 26108 | 21:55:10 INFO - PID 26108 | Cycle 1(1): loaded http://localhost:57878/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57878/tests/dromaeo/cssquery-prototype.html) 21:55:11 INFO - PID 26108 | RSS: Main: 271589376 21:55:11 INFO - PID 26108 | 21:58:15 INFO - PID 26108 | Cycle 1(1): loaded http://localhost:57878/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57878/tests/dromaeo/cssquery-yui.html) 21:58:16 INFO - PID 26108 | RSS: Main: 278728704 21:58:16 INFO - PID 26108 | 22:01:18 INFO - PID 26108 | Cycle 1(1): loaded http://localhost:57878/tests/dromaeo/cssquery-yui.html (next: http://localhost:57878/tests/dromaeo/cssquery-dojo.html) 22:01:18 INFO - PID 26108 | RSS: Main: 279662592 22:01:18 INFO - PID 26108 | 22:01:18 INFO - PID 26108 | __start_tp_report 22:01:18 INFO - PID 26108 | _x_x_mozilla_page_load 22:01:18 INFO - PID 26108 | _x_x_mozilla_page_load_details 22:01:18 INFO - PID 26108 | |i|pagename|runs| 22:01:18 INFO - PID 26108 | |0;dojo.html;3138.199759061439;3144.7955882867614;3172.8096314221143;3180.4434224010793;3197.9840100799493;6141.324454310034;6161.784337548187;6200.565960382769;6273.404026617475;6302.432781049704;6218.875622487548;6230.28351739549;6235.376462353763;6260.499160067195;6273.466755325803;5636.436356364372;5689.089745640698;5700.287464066992;5727.198192253088;5769.278840144982;5684.857878553049;5701.914471282934;5704.458076482748;5749.683767392792;5771.105478650816;5666.348369937448;5715.628484148538;5740.827775166731;5745.368009518949;5752.424757524256;5725.713714314309;5740.9712951435395;5742.052561327376;5757.050086735704;5772.6536407815665;5624.3250809903075;5756.251687280626;5765.279340082489;5769.365369809318;5790.420957904218;6171.228596425447;6200.286966998808;6244.843878903063;6328.398802113792;6335.5565110442285;6546.6726663667105;6646.833829154261;6704.463642908556;6755.290694477058;6818.727250909958;6228.22147231596;6720.5295629305965;6814.48891333147;6844.623545704984;6858.862822743517;6260.311365749764;6272.2159730033745;6278.0269058296035;6311.652859092748;6339.36606339367;6797.524173307821;6900.827479313058;6908.412784913238;6985.057017302701;7009.228984811667;6512;6558.409743123047;6579.309172536815;6581.76963806274;6584.440322572539;6685.331466853276;6712.630805305657;6733.6296503692765;6758.7296508139125;6768.153980752406;6668.899966500507;6693.866122677617;6694.196696396463;6700.061991321219;6725.159355080615;6710.127683401127;6732.057511948331;6756.986452032234;6795.490338224653;6798.2182049064;5353.866153346197;5401.918971215357;5442.210879422461;5445;5449.237106805051;4549.3176023596725;4608.792604332813;4634.37435946143;4652.069586082729;4682.250839865674;5699.601027928005;5709;5720.227769251098;5765.538756899438;5765.567582431335;6688.963210702349;6734.696938637773;6756.560823546453;6757.662116894234;6768.627725475146;5744.942550574524;5820.679862607597;5831;5834.008218602848;5845;5761.971190144022;5869.295684517885;5884.293884733859;5902.61632993854;5966.284045914518;6506;6509.2839787623325;6510.707018184193;6515.087887695727;6530;6649.60102393858;6655.267920528738;6682.866342673216;6685.799426017227;6692.966535167293;6341.143945567474;6484.416402523795;6515.543911926309;6574.8356291093105;6645.667716614246;6522.21733391996;6602.867942641216;6607.933920660732;6646.83382915431;6726.7981960541265;6762.695678694372;6774.8645027100165;6800.115984921928;6810;6811.591304521745;6476.902846457401;6489.415952564292;6559.245686746085;6574.342565743579;6582.440492558187;5447.4824891635235;6503.382178693017;6516.283208846929;6516.73933042673;6617.7683781067435;6449.258335291313;6452.709628066842;6530.314316996837;6546.345365463416;6569.901451478136;6459.903101453576;6613.107230523818;6615.4376877965915;6626.370494802986;6715.093462382712;6267.62394256346;6366.204224471941;6401.967990160019;6409.327020662763;6431.356864313531 22:01:18 INFO - PID 26108 | |1;ext.html;813.9470934389265;822.7408366364598;848.7496188624356;873.7597160780784;875.8773771671963;39566.802165989204;40448.59551404485;40517.594824051754;40663.59336406642;40704;36388.45417318743;36523;36621.63378366215;36890.63109368906;37055.44416833743;6759.526833121671;6859.485538584601;6879.036934829128;6885.896711549306;6888.483363747714;6698.1292431983775;6783.253842077367;6786.558873673195;6794.252632210453;6798.626075565842;7305.196428392873;7467.402607791364;7487.513311634726;7498.100227972651;7517.36102431294;7406.666699998513;7415.961765352828;7460.14208366034;7471.215522370155;7471.887921681152;7328.120625524918;7380.520266182734;7400.333969942677;7442.404607631376;7565.319121279056;38295.42556861649;38708.45166193349;38805.41791873124;38903;38938.221235575416;3532.788032718045;3574.6425357464304;3577.588577313616;3580.230250496156;3580.480830279595;30435.23911902198;30538.54192187119;30586;30645.233869153228;30671.38657226843;5012.348394708664;5033.748312584356;5035.269885866529;5036.395632524121;5055.292259083732;222347;222779;225924;226914;227332.99999999834;48109;48591;48603.27095093577;48805.26792098051;49055.75472122616;50892.236616450784;50946.74526627343;51020.23469647958;51140.23289650658;51173.929564226266;16346.836531634532;16387.754183687255;16668.41660541875;16712.916435417745;16747.330106795835;13044.804327935088;13372.33138343079;13672;13725.656858578615;13798;14530.128192308495;14638.414463421557;14834.406623735145;14914.850851491563;15026.69946601062;5838.4453476919625;6149.600275982047;6176.752929882844;6197.183098591496;6203.875922481525;1005.1406047829147;1025.2771795883884;1031.9690409287734;1035.1822060572215;1050.3172937590627;23004;23325.53348933012;23355.88322058379;23471.53056938886;23546.529069418517;1122.7586068995042;1133.8582677165355;1142.8400023996646;1146.4210573660414;1159.2059439284117;12427.627171184879;12453.501859925502;12494.937525312314;12497.18768280059;12551.811722824164;237753;237764;238152;238346;238495;44623;45718.542814571425;45795.77102114468;51976.22035669468;52251;1480.726065677853;1481.15574122749;1484.161448781435;1485.5469081930114;1485.947991820281;28114;28275.71724282813;28421.715782841908;28486;29156;37058.25883482369;50841.49158508368;51953;52023.479765203374;52115.21827172671;209226;210482;211463;211935;213046;36074.63925360818;36354;36429;36462.63537364698;36492.635073648926;43093.35359969666;44652.106957860015;44901.55098449104;44971.32543011792;45364.31953520766;32652.83673581617;32735.83632081824;33323.83338083294;33537.16157096092;33800.49299260464;32285.35429291354;32428.513572295964;32766.34467310688;34252.31495370129;35779.46330804988;36975.260494789414;37381;37685.81157094197;37759.244815104095;37765.4335184978;32118;32447.35105297928;34248.82875585706;34400.655993439745;34578.30843383068;24707.62938555959;24910.875445622656;25334.493310133326;25803;25826.504097541325 22:01:18 INFO - PID 26108 | |2;jquery.html;557.1308758336994;579.7854793726319;584.6199970019484;585.4379795396419;590.1177739279777;22483.662745058817;23200;23286.65070023951;23289.534209315803;23293.767062329393;25418.11036613719;27529.724702752967;27730.02944896929;27985.440291194165;27987.160385188476;7038.718451261943;7130.893036604455;7149.7497587584185;7203.855922881539;7206.027186329831;6564.179477565304;6875.106236189288;7079.64601769912;7104.68028938699;7158.248383919691;6822.215445223788;6834.179898412198;6838.965805170992;6845.931540684579;6847.965760171217;6783.3216678332265;6805.693743781541;6841.726330946756;6846.794596162098;6847.383735463807;6659.03444000622;6683.2982536833415;6694.297098804653;6700.932990670129;6701.329867013308;30409.69590304091;31585.21036974094;31672.841635791672;31838.681613184035;32070;1913.540750219937;1935.4387227703949;1944.7374604428362;1953.4725624081418;1957.725918371429;20005.29981450657;21166.153353865826;21180.470488237763;21272.680909786366;21447.8927605361;2530.329462692388;2548.604966230237;2644.854533000684;2651.787856971457;2652.2175958092407;143804;146657;147760.52239477576;148027;148277;19968.90015549913;21314.573708525742;22373.664395034088;22532.662010069864;23224.4193895154;44388.77805610951;44653.55346446494;44696.3295550567;44716.77641611771;44959.55040449619;11390.145739069438;11715.76568468626;11808.70478238051;11936.28382297065;12039.157258991787;9790.951045244728;9834.065763752433;9870.950645246729;10069.144122749649;10112.949435252776;8853.46879187238;9204.171624553823;9246.722598322061;9444.90555094454;11092.223544351818;2607.76530112287;2674.772644325254;2683.8196736866876;2703.9729602704115;2727.440874620698;944.9385789923771;975.6487664440796;985.103555764251;995.144176008632;998.605550807427;19464.513387165433;19650.21399144018;19944.70082948757;19952.20191192336;24377;1055.176961969665;1070.4915165296577;1074.5003573338436;1083.1226706367868;1087.472575800736;11289.435528223556;11623.88376116245;11689.18175727708;11707.824382634268;11778.175527713149;549761;556724;563400;565109;567529;116587;119587;120224;120666.38000859988;123380;1250.93745312734;1281.8910392616544;1284.7494738526084;1299.4412402666944;1301.4078594239597;18325.175367108244;18385;18494.537636559195;18609.69732118739;18897.716534251722;56898;57160.42839571551;57849;60163.69918150381;60402.69798650979;71533;71977;72230;72303.63848180725;73610;11912.463939122934;12250.448729807002;13009.284489353176;14378.856211437751;14652.19412932299;22239.332820015425;22457.101715931833;22549.098036078372;23094.307170784905;23397.298081057597;18358.265669373075;18460.261589536807;18490.907545462724;18494.907525462826;18603.255869765057;15875.364985400454;16054.759178612096;16592.585185370463;17283.395081172097;17492.82507174912;18736.718949216047;18899.527511812314;19054.523636909187;19213.135408906353;19301.517462063563;14245.430182792572;14701.264936753334;14716.705665886408;14964.700705985602;14966.625834354229;17000.404985825437;17202.483925482255;18877.811221888154;19098;19206 22:01:18 INFO - PID 26108 | |3;mootools.html;1301.6550614087266;1378.2832926878018;1384.377030336349;1393.2128347483672;1401.964950876228;13930.164190148598;14513.49202777903;14597.70804583909;14660.926695366508;14693.853061469383;12236.26582405054;12712.173708708928;12731.108822382437;13635.113717608348;14095.71808563828;2644.074573899139;2719.1978366381963;2736.9589456158174;2743.9588406173825;2748.6014527893444;2660.948925174555;2682.825616334942;2706.269307287031;2714.4164004738977;2716.144414509433;2607.413332000304;2801.1876555798794;2807.03157410693;2809.2836326736656;2810.1990932584217;2749.505089083964;2755.476459472694;2767.778577713778;2769.62610047645;2786.5680819473114;2719.279390961397;2725.0870958229016;2726.2502811726736;2756.8483733394655;2759.3377589378406;14055.156690598596;14315;14404.423823047066;14432.567022989328;14446.855531444657;7562.168161502231;7861.21387861215;7891.131975482693;7907.44647874649;7936.246056624669;5051.6716413433005;5083.262926875583;5196.53231209193;5279.128943724281;5280.973595132;1857.182839550607;1894.5358387195088;1902.3531999120228;1918.7313776071362;1922.5770330527262;23633.7636623635;24218.39454013646;24354.63468047981;24410.267691969268;24459.143929962545;6687.866242675216;6898.206706228748;6929.68816403253;7125.714971401086;7148.428125749928;19173.424797256106;19234.615307693766;19319.22723091089;19327;19339.613207735765;7786.532808031537;7834.569098699512;7933.404994625426;8143.307818835347;8170.509769413854;7183.06620139389;7230.602316872517;7297.671604777798;7298.890516642255;7327.706891724378;5096.694198348111;5218.8956220876125;5266.2890509781455;5270.552003079782;5300.35688936431;1326.316946772413;1342.2080972226433;1500.7298686236363;1514.2050423527517;1520.429838810446;875.8248350329959;882.1090698394668;896.1531352871474;901.8151278987923;911.7538264668635;8699.695510657224;8872.512011839282;8969.865452018224;8980.595873185723;9049.547522623843;955.7371722776153;957.9712608621752;970.7042843674659;971.6016433262329;998.7053819123377;5375.75809088592;5401.4868587484125;5412.377576578665;5414.18787181918;5608.158776183605;19254;20118.899405502878;20170.69743953842;20223.898880505505;20309.390718278475;17014.829851701572;19764.90117549403;19830.107645156004;19928.402147935583;20103.698444523343;11027.283226590245;11075.280106793032;11312.773744525064;11313.886861131448;11361.829572556418;8283.337333013465;8476.49141051539;8690.608922598372;8741.519216442903;8836.293096552388;16465.83534164643;16778.832211677727;16977;17035.31858725637;17071.487855364358;16113.597160071093;17122.229499672794;17253.13734313254;17303.91348043252;17715.114244287994;11700.765984680089;11748.412579370826;12021.519139234333;12037.75924481523;12065.336406497376;13413;13662.863371366557;13683.589492315246;13701.520446784314;13718.245496497788;10913.508892100033;11130.443477825915;11195.888041119484;11267.492962816528;11614.535418583162;10797.190210734068;10859.457027148768;10934.671959841218;11314.434278285888;11320.207585468937;9673.516324183904;9766.75583110428;9778.462184579916;9822.066903644143;9827.213822894295;7206.351428371472;7262.564246145248;7344.632768361454;7351.154617219088;7366.558006519626;7419.629018548943;7452.993845830743;7521.398288137046;7521.548707077593;7567.659455324634 22:01:18 INFO - PID 26108 | |4;prototype.html;476.4378033919973;495.50547962073637;512.2546694559417;516.7287174233525;519.5116590405019;6102.206713127298;6180.351063138373;6190.473809726167;6234.882558720639;6241.875162496747;5956.404359564041;6062.727177277022;6065.181200537926;6066;6090.421409966058;4854.349521162804;4856.198727210006;4884.291777692232;4939.851804445854;4963.950360496385;4884.508900460773;4960.206366981283;4969.652124351297;4973.3286006389035;4997.001199520185;4711.481737008926;4870.512948705119;4886.975565122169;4890.633202509826;4944.777485013183;4839.483468596311;4878.4145902491755;4904.901901961976;4920.384951881015;4942.3327850740225;4348.651917905428;4360.21516127097;4380.255356589356;4395.780210989437;4400.713953593038;5928.7332070056955;5930.55520835939;5941.732622032019;5977.133315669247;5985.371535988702;5623.746931388097;5641.266635337421;5652;5663.575231857627;5718.170865224561;6472.935270647327;6527.412532872065;6532.7713530026695;6540.234136783042;6556.18047744032;4782.52174782519;4794.592459640935;4811.975940120312;4823.324734537167;4872.0499502597;6870.416014638762;6877.965610171917;6911.7926462206215;6966.442684585221;6993.860122797567;4951.752412379366;4962.131626965339;4962.206047032458;4968.180250258667;4980.526849949249;4986.556587272211;4992.530191516861;5002.699838009731;5011.924821127686;5066.797328106908;5589.441055894378;5633.732410207671;5640.351359593617;5671.886562268732;5728.369879313273;6464.967675161688;6533.281339052701;6555.508336874754;6557.573757705733;6599.868002639921;1649.7030534503904;1737.9826201738074;1745.3542189389752;1760.8679349048616;1761.5243884151464;1110.3227031510771;1169.6140273709655;1187.857457105153;1195.964121076369;1211.4366819429008;5609.971950140223;5634.323881134208;5667.1499275108235;5671.546276297886;5687.521244476383;6519.608823470607;6552.279249282575;6555.704993275314;6593.703283352261;6705.2624211336715;5620.325560932714;5654.208410822488;5679;5690.943090569124;5718.513926316226;3504.5093686883856;3518.3491054155065;3539.9292014159573;3549.94675079874;3561;6357.237131544244;6424.229092508929;6432.871342573122;6433.967830160819;6442.516811239176;6655.633940133339;6696.46428285736;6736.865262694719;6743.831404214836;6800.557963732342;6403.615783053032;6403.839904002437;6459.224893012869;6476.902846457401;6507.804765857032;6597.119820851034;6598.835029124119;6625.900611490928;6629.7348106075215;6633.3035031321015;6514.478841692748;6574.80275591733;6622.536422450382;6658.234303055211;6683.465322774264;6399.488040956805;6424.871502569829;6454.128692626436;6454.160959075478;6470.741170353133;4938.555530002317;4940.333055037668;4972.9254061188385;4973.726445045557;5006.299118123538;6551.279359270381;6561.901571476527;6576.934230657632;6586.736530538725;6692.933070669231;6237.407446292595;6311.368863113836;6345.1434056401795;6398.424141827071;6438.871222575616;6353.1893410377825;6395.345931438401;6423.582467139621;6453.386928241809;6470.417662410406;5903.321118071477;6223.751049957951;6283.2460104787715;6336.320874968229;6386.9680651596445;6439.195100612424;6542.855000375011;6565.573237739532;6596.317938925543;6597.3072827352435;6240.344763799917;6261.812145635638;6299.275583307978;6335.176427064452;6360.204974378203 22:01:18 INFO - PID 26108 | |5;yui.html;858.7724253072932;888.6756333938115;903.5075883643414;907.0566610724845;915.208344781764;18831;19292.131854066567;19306.613867722637;19410.51473713158;19571;14855.702885942275;15710.057396556185;15784.21078946051;20076;20157.59684806303;1027.835546312592;1044.2011860926398;1045.2683121814723;1046.879608844985;1055.0135623192302;1052.3054783842665;1053.978920421591;1055.5250137438145;1056.3028401255174;1061.633736360958;1057.5346847387164;1101.3061771084247;1109.7003808971572;1113.6547670222258;1117.932924024557;1089.8746644135947;1099.5217080569978;1101.763120929;1104.6685994201787;1114.025227925565;795.1849354411717;796.0646240667251;800.2797482265948;806.0810675829559;809.8299357135008;18783;19011.239550417966;19023.80976190248;19089.713654295196;20635.48411289715;22167.44581385462;22332.776672233394;22444.55110897773;22565.210217642303;22852.542949140923;15466;15890.52328430149;16077.356905723756;16147.03117812935;16252.431164909289;3469.323481921001;3495.5805303363504;3502.579690437138;3515.9296814063578;3523.2953409317984;125095;126789.36605316914;127130.3643481786;127613.99999999907;130539.34730326383;14815.703685926437;14885.33016014282;15030.09819410817;15279.541613751606;15342.309596068204;27036.459270814867;27215.591766123525;27400.177994660193;27463.313417164733;27489.31276718098;8698.913010869937;8848.955755221183;8913.24237439812;8923.776905577413;8946;3882.281777871103;3964.8215830287704;3964.980175099106;3967.305721498726;3979.721419500665;5103.668261562986;5792.391798861143;6012.789552365646;6048.818535443944;6064.363241859542;1028.6554004408458;1072.3940973350032;1073.382804887193;1080.2654195147375;1083.0577397664083;671.3152584364019;685.5578152091873;698.8078278473461;704.6828926982878;708.5571517801374;11424.828627570592;12012.63962081139;12016.09879259059;12172.57395991136;14269.85730142706;700.6776882634045;703.736098962889;709.3651182191909;717.7165019817143;727.2618292433184;5688.317401911797;5728.828135155952;5982.880342393128;5993.4905533029305;6085.056816193497;107229;109795;110815.44592276987;114492.42753786177;115435.42282288703;93026.53486732523;93301.53349233346;94606;96433.51783241039;96800.51599741956;83466.58266708627;83833.58083209545;87289.56355218183;87533.56233218792;87766.56116719503;12518.311492867979;12751.744965100832;12867.099303048697;12988.350582471028;12994.805077924028;39717.40423893586;40154;41722.79138604409;41949.580504194564;42260.78869605633;51094.48905511046;51232;52476.47523524868;52683.47316526939;53466;18430.078496074875;18670.253189872252;18974.810251897856;19037.238510459425;19090.809091908905;19727.11227994715;19782.50543736418;19892.90053549723;19941.60116797685;19980.50048748793;18960.146793394055;19003.524911877314;19191.424257272305;19210.039498025322;19504.414867553995;18176.636467270844;19037.619247615246;19239.134238959;19680.507987300432;19956.50108747235;17313.826861731726;17657.646847063243;17794.288228470716;17961.461156165336;18155.36456224026;12708.618741437771;13414.597562073153;13893.374798133906;14129.576112716635;14700.926495367456;14259.572212833631;14423.8460923128;14799.556013319618;14991.925040375165;15059.924700376429 22:01:18 INFO - PID 26108 | __end_tp_report 22:01:18 INFO - PID 26108 | __start_cc_report 22:01:18 INFO - PID 26108 | _x_x_mozilla_cycle_collect,394 22:01:18 INFO - PID 26108 | __end_cc_report 22:01:18 INFO - PID 26108 | __startTimestamp1502946078614__endTimestamp 22:01:18 INFO - PID 26108 | 22:01:18 INFO - PID 26108 | ------- Summary: start ------- 22:01:18 INFO - PID 26108 | Number of tests: 6 22:01:18 INFO - PID 26108 | 22:01:18 INFO - PID 26108 | [#0] dojo.html Cycles:165 Average:6167.95 Median:6431.36 stddev:737.11 (11.5%) stddev-sans-first:700.01 22:01:18 INFO - PID 26108 | Values: 3138.2 3144.8 3172.8 3180.4 3198.0 6141.3 6161.8 6200.6 6273.4 6302.4 6218.9 6230.3 6235.4 6260.5 6273.5 5636.4 5689.1 5700.3 5727.2 5769.3 5684.9 5701.9 5704.5 5749.7 5771.1 5666.3 5715.6 5740.8 5745.4 5752.4 5725.7 5741.0 5742.1 5757.1 5772.7 5624.3 5756.3 5765.3 5769.4 5790.4 6171.2 6200.3 6244.8 6328.4 6335.6 6546.7 6646.8 6704.5 6755.3 6818.7 6228.2 6720.5 6814.5 6844.6 6858.9 6260.3 6272.2 6278.0 6311.7 6339.4 6797.5 6900.8 6908.4 6985.1 7009.2 6512.0 6558.4 6579.3 6581.8 6584.4 6685.3 6712.6 6733.6 6758.7 6768.2 6668.9 6693.9 6694.2 6700.1 6725.2 6710.1 6732.1 6757.0 6795.5 6798.2 5353.9 5401.9 5442.2 5445.0 5449.2 4549.3 4608.8 4634.4 4652.1 4682.3 5699.6 5709.0 5720.2 5765.5 5765.6 6689.0 6734.7 6756.6 6757.7 6768.6 5744.9 5820.7 5831.0 5834.0 5845.0 5762.0 5869.3 5884.3 5902.6 5966.3 6506.0 6509.3 6510.7 6515.1 6530.0 6649.6 6655.3 6682.9 6685.8 6693.0 6341.1 6484.4 6515.5 6574.8 6645.7 6522.2 6602.9 6607.9 6646.8 6726.8 6762.7 6774.9 6800.1 6810.0 6811.6 6476.9 6489.4 6559.2 6574.3 6582.4 5447.5 6503.4 6516.3 6516.7 6617.8 6449.3 6452.7 6530.3 6546.3 6569.9 6459.9 6613.1 6615.4 6626.4 6715.1 6267.6 6366.2 6402.0 6409.3 6431.4 22:01:18 INFO - PID 26108 | 22:01:18 INFO - PID 26108 | [#1] ext.html Cycles:180 Average:39603.91 Median:36214.32 stddev:58344.81 (161.1%) stddev-sans-first:58435.78 22:01:18 INFO - PID 26108 | Values: 813.9 822.7 848.7 873.8 875.9 39566.8 40448.6 40517.6 40663.6 40704.0 36388.5 36523.0 36621.6 36890.6 37055.4 6759.5 6859.5 6879.0 6885.9 6888.5 6698.1 6783.3 6786.6 6794.3 6798.6 7305.2 7467.4 7487.5 7498.1 7517.4 7406.7 7416.0 7460.1 7471.2 7471.9 7328.1 7380.5 7400.3 7442.4 7565.3 38295.4 38708.5 38805.4 38903.0 38938.2 3532.8 3574.6 3577.6 3580.2 3580.5 30435.2 30538.5 30586.0 30645.2 30671.4 5012.3 5033.7 5035.3 5036.4 5055.3 222347.0 222779.0 225924.0 226914.0 227333.0 48109.0 48591.0 48603.3 48805.3 49055.8 50892.2 50946.7 51020.2 51140.2 51173.9 16346.8 16387.8 16668.4 16712.9 16747.3 13044.8 13372.3 13672.0 13725.7 13798.0 14530.1 14638.4 14834.4 14914.9 15026.7 5838.4 6149.6 6176.8 6197.2 6203.9 1005.1 1025.3 1032.0 1035.2 1050.3 23004.0 23325.5 23355.9 23471.5 23546.5 1122.8 1133.9 1142.8 1146.4 1159.2 12427.6 12453.5 12494.9 12497.2 12551.8 237753.0 237764.0 238152.0 238346.0 238495.0 44623.0 45718.5 45795.8 51976.2 52251.0 1480.7 1481.2 1484.2 1485.5 1485.9 28114.0 28275.7 28421.7 28486.0 29156.0 37058.3 50841.5 51953.0 52023.5 52115.2 209226.0 210482.0 211463.0 211935.0 213046.0 36074.6 36354.0 36429.0 36462.6 36492.6 43093.4 44652.1 44901.6 44971.3 45364.3 32652.8 32735.8 33323.8 33537.2 33800.5 32285.4 32428.5 32766.3 34252.3 35779.5 36975.3 37381.0 37685.8 37759.2 37765.4 32118.0 32447.4 34248.8 34400.7 34578.3 24707.6 24910.9 25334.5 25803.0 25826.5 22:01:18 INFO - PID 26108 | 22:01:18 INFO - PID 26108 | [#2] jquery.html Cycles:180 Average:38298.41 Median:23147.15 stddev:93800.97 (405.2%) stddev-sans-first:94021.31 22:01:18 INFO - PID 26108 | Values: 557.1 579.8 584.6 585.4 590.1 22483.7 23200.0 23286.7 23289.5 23293.8 25418.1 27529.7 27730.0 27985.4 27987.2 7038.7 7130.9 7149.7 7203.9 7206.0 6564.2 6875.1 7079.6 7104.7 7158.2 6822.2 6834.2 6839.0 6845.9 6848.0 6783.3 6805.7 6841.7 6846.8 6847.4 6659.0 6683.3 6694.3 6700.9 6701.3 30409.7 31585.2 31672.8 31838.7 32070.0 1913.5 1935.4 1944.7 1953.5 1957.7 20005.3 21166.2 21180.5 21272.7 21447.9 2530.3 2548.6 2644.9 2651.8 2652.2 143804.0 146657.0 147760.5 148027.0 148277.0 19968.9 21314.6 22373.7 22532.7 23224.4 44388.8 44653.6 44696.3 44716.8 44959.6 11390.1 11715.8 11808.7 11936.3 12039.2 9791.0 9834.1 9871.0 10069.1 10112.9 8853.5 9204.2 9246.7 9444.9 11092.2 2607.8 2674.8 2683.8 2704.0 2727.4 944.9 975.6 985.1 995.1 998.6 19464.5 19650.2 19944.7 19952.2 24377.0 1055.2 1070.5 1074.5 1083.1 1087.5 11289.4 11623.9 11689.2 11707.8 11778.2 549761.0 556724.0 563400.0 565109.0 567529.0 116587.0 119587.0 120224.0 120666.4 123380.0 1250.9 1281.9 1284.7 1299.4 1301.4 18325.2 18385.0 18494.5 18609.7 18897.7 56898.0 57160.4 57849.0 60163.7 60402.7 71533.0 71977.0 72230.0 72303.6 73610.0 11912.5 12250.4 13009.3 14378.9 14652.2 22239.3 22457.1 22549.1 23094.3 23397.3 18358.3 18460.3 18490.9 18494.9 18603.3 15875.4 16054.8 16592.6 17283.4 17492.8 18736.7 18899.5 19054.5 19213.1 19301.5 14245.4 14701.3 14716.7 14964.7 14966.6 17000.4 17202.5 18877.8 19098.0 19206.0 22:01:18 INFO - PID 26108 | 22:01:18 INFO - PID 26108 | [#3] mootools.html Cycles:180 Average:9054.87 Median:2715.28 stddev:6171.55 (227.3%) stddev-sans-first:6161.37 22:01:18 INFO - PID 26108 | Values: 1301.7 1378.3 1384.4 1393.2 1402.0 13930.2 14513.5 14597.7 14660.9 14693.9 12236.3 12712.2 12731.1 13635.1 14095.7 2644.1 2719.2 2737.0 2744.0 2748.6 2660.9 2682.8 2706.3 2714.4 2716.1 2607.4 2801.2 2807.0 2809.3 2810.2 2749.5 2755.5 2767.8 2769.6 2786.6 2719.3 2725.1 2726.3 2756.8 2759.3 14055.2 14315.0 14404.4 14432.6 14446.9 7562.2 7861.2 7891.1 7907.4 7936.2 5051.7 5083.3 5196.5 5279.1 5281.0 1857.2 1894.5 1902.4 1918.7 1922.6 23633.8 24218.4 24354.6 24410.3 24459.1 6687.9 6898.2 6929.7 7125.7 7148.4 19173.4 19234.6 19319.2 19327.0 19339.6 7786.5 7834.6 7933.4 8143.3 8170.5 7183.1 7230.6 7297.7 7298.9 7327.7 5096.7 5218.9 5266.3 5270.6 5300.4 1326.3 1342.2 1500.7 1514.2 1520.4 875.8 882.1 896.2 901.8 911.8 8699.7 8872.5 8969.9 8980.6 9049.5 955.7 958.0 970.7 971.6 998.7 5375.8 5401.5 5412.4 5414.2 5608.2 19254.0 20118.9 20170.7 20223.9 20309.4 17014.8 19764.9 19830.1 19928.4 20103.7 11027.3 11075.3 11312.8 11313.9 11361.8 8283.3 8476.5 8690.6 8741.5 8836.3 16465.8 16778.8 16977.0 17035.3 17071.5 16113.6 17122.2 17253.1 17303.9 17715.1 11700.8 11748.4 12021.5 12037.8 12065.3 13413.0 13662.9 13683.6 13701.5 13718.2 10913.5 11130.4 11195.9 11267.5 11614.5 10797.2 10859.5 10934.7 11314.4 11320.2 9673.5 9766.8 9778.5 9822.1 9827.2 7206.4 7262.6 7344.6 7351.2 7366.6 7419.6 7453.0 7521.4 7521.5 7567.7 22:01:18 INFO - PID 26108 | 22:01:18 INFO - PID 26108 | [#4] prototype.html Cycles:180 Average:5438.94 Median:5981.25 stddev:1529.23 (25.6%) stddev-sans-first:1487.47 22:01:18 INFO - PID 26108 | Values: 476.4 495.5 512.3 516.7 519.5 6102.2 6180.4 6190.5 6234.9 6241.9 5956.4 6062.7 6065.2 6066.0 6090.4 4854.3 4856.2 4884.3 4939.9 4964.0 4884.5 4960.2 4969.7 4973.3 4997.0 4711.5 4870.5 4887.0 4890.6 4944.8 4839.5 4878.4 4904.9 4920.4 4942.3 4348.7 4360.2 4380.3 4395.8 4400.7 5928.7 5930.6 5941.7 5977.1 5985.4 5623.7 5641.3 5652.0 5663.6 5718.2 6472.9 6527.4 6532.8 6540.2 6556.2 4782.5 4794.6 4812.0 4823.3 4872.0 6870.4 6878.0 6911.8 6966.4 6993.9 4951.8 4962.1 4962.2 4968.2 4980.5 4986.6 4992.5 5002.7 5011.9 5066.8 5589.4 5633.7 5640.4 5671.9 5728.4 6465.0 6533.3 6555.5 6557.6 6599.9 1649.7 1738.0 1745.4 1760.9 1761.5 1110.3 1169.6 1187.9 1196.0 1211.4 5610.0 5634.3 5667.1 5671.5 5687.5 6519.6 6552.3 6555.7 6593.7 6705.3 5620.3 5654.2 5679.0 5690.9 5718.5 3504.5 3518.3 3539.9 3549.9 3561.0 6357.2 6424.2 6432.9 6434.0 6442.5 6655.6 6696.5 6736.9 6743.8 6800.6 6403.6 6403.8 6459.2 6476.9 6507.8 6597.1 6598.8 6625.9 6629.7 6633.3 6514.5 6574.8 6622.5 6658.2 6683.5 6399.5 6424.9 6454.1 6454.2 6470.7 4938.6 4940.3 4972.9 4973.7 5006.3 6551.3 6561.9 6576.9 6586.7 6692.9 6237.4 6311.4 6345.1 6398.4 6438.9 6353.2 6395.3 6423.6 6453.4 6470.4 5903.3 6223.8 6283.2 6336.3 6387.0 6439.2 6542.9 6565.6 6596.3 6597.3 6240.3 6261.8 6299.3 6335.2 6360.2 22:01:18 INFO - PID 26108 | 22:01:18 INFO - PID 26108 | [#5] yui.html Cycles:180 Average:23192.57 Median:19299.37 stddev:31551.52 (163.5%) stddev-sans-first:31595.47 22:01:18 INFO - PID 26108 | Values: 858.8 888.7 903.5 907.1 915.2 18831.0 19292.1 19306.6 19410.5 19571.0 14855.7 15710.1 15784.2 20076.0 20157.6 1027.8 1044.2 1045.3 1046.9 1055.0 1052.3 1054.0 1055.5 1056.3 1061.6 1057.5 1101.3 1109.7 1113.7 1117.9 1089.9 1099.5 1101.8 1104.7 1114.0 795.2 796.1 800.3 806.1 809.8 18783.0 19011.2 19023.8 19089.7 20635.5 22167.4 22332.8 22444.6 22565.2 22852.5 15466.0 15890.5 16077.4 16147.0 16252.4 3469.3 3495.6 3502.6 3515.9 3523.3 125095.0 126789.4 127130.4 127614.0 130539.3 14815.7 14885.3 15030.1 15279.5 15342.3 27036.5 27215.6 27400.2 27463.3 27489.3 8698.9 8849.0 8913.2 8923.8 8946.0 3882.3 3964.8 3965.0 3967.3 3979.7 5103.7 5792.4 6012.8 6048.8 6064.4 1028.7 1072.4 1073.4 1080.3 1083.1 671.3 685.6 698.8 704.7 708.6 11424.8 12012.6 12016.1 12172.6 14269.9 700.7 703.7 709.4 717.7 727.3 5688.3 5728.8 5982.9 5993.5 6085.1 107229.0 109795.0 110815.4 114492.4 115435.4 93026.5 93301.5 94606.0 96433.5 96800.5 83466.6 83833.6 87289.6 87533.6 87766.6 12518.3 12751.7 12867.1 12988.4 12994.8 39717.4 40154.0 41722.8 41949.6 42260.8 51094.5 51232.0 52476.5 52683.5 53466.0 18430.1 18670.3 18974.8 19037.2 19090.8 19727.1 19782.5 19892.9 19941.6 19980.5 18960.1 19003.5 19191.4 19210.0 19504.4 18176.6 19037.6 19239.1 19680.5 19956.5 17313.8 17657.6 17794.3 17961.5 18155.4 12708.6 13414.6 13893.4 14129.6 14700.9 14259.6 14423.8 14799.6 14991.9 15059.9 22:01:18 INFO - PID 26108 | -------- Summary: end -------- 22:01:18 INFO - PID 26108 | 22:01:19 INFO - TEST-INFO | 26108: exit 0 22:01:19 INFO - TEST-OK | dromaeo_css | took 1115795ms 22:01:19 INFO - TEST-START | kraken 22:01:19 INFO - Initialising browser for kraken test... 22:01:19 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57878/getInfo.html -profile /tmp/tmpn21qE4/profile 22:01:19 INFO - TEST-INFO | started process 26481 (/builds/slave/test/build/application/firefox/firefox http://localhost:57878/getInfo.html) 22:01:25 INFO - TEST-INFO | 26481: exit 0 22:01:25 INFO - Browser initialized. 22:01:25 INFO - Running cycle 1/1 for kraken test... 22:01:25 INFO - TEST-INFO | started process 26665 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn21qE4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 22:01:26 INFO - PID 26665 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 22:01:26 INFO - PID 26665 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 22:01:26 INFO - PID 26665 | 22:01:26 INFO - PID 26665 | (/builds/slave/test/build/application/firefox/firefox:26724): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 22:01:26 INFO - PID 26665 | 22:01:37 INFO - PID 26665 | RSS: Main: 194408448 22:01:37 INFO - PID 26665 | 22:01:39 INFO - PID 26665 | Cycle 1(1): loaded http://localhost:57878/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57878/tests/kraken/driver.html?testName=audio-beat-detection) 22:01:40 INFO - PID 26665 | RSS: Main: 204181504 22:01:40 INFO - PID 26665 | 22:01:43 INFO - PID 26665 | Cycle 1(1): loaded http://localhost:57878/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57878/tests/kraken/driver.html?testName=audio-dft) 22:01:44 INFO - PID 26665 | RSS: Main: 205238272 22:01:44 INFO - PID 26665 | 22:01:47 INFO - PID 26665 | Cycle 1(1): loaded http://localhost:57878/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57878/tests/kraken/driver.html?testName=audio-fft) 22:01:47 INFO - PID 26665 | RSS: Main: 200740864 22:01:47 INFO - PID 26665 | 22:01:50 INFO - PID 26665 | Cycle 1(1): loaded http://localhost:57878/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57878/tests/kraken/driver.html?testName=audio-oscillator) 22:01:50 INFO - PID 26665 | RSS: Main: 198815744 22:01:50 INFO - PID 26665 | 22:01:52 INFO - PID 26665 | Cycle 1(1): loaded http://localhost:57878/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57878/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:01:53 INFO - PID 26665 | RSS: Main: 212533248 22:01:53 INFO - PID 26665 | 22:01:56 INFO - PID 26665 | Cycle 1(1): loaded http://localhost:57878/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57878/tests/kraken/driver.html?testName=imaging-darkroom) 22:01:57 INFO - PID 26665 | RSS: Main: 214704128 22:01:57 INFO - PID 26665 | 22:02:00 INFO - PID 26665 | Cycle 1(1): loaded http://localhost:57878/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57878/tests/kraken/driver.html?testName=imaging-desaturate) 22:02:01 INFO - PID 26665 | RSS: Main: 216412160 22:02:01 INFO - PID 26665 | 22:02:04 INFO - PID 26665 | Cycle 1(1): loaded http://localhost:57878/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57878/tests/kraken/driver.html?testName=json-parse-financial) 22:02:05 INFO - PID 26665 | RSS: Main: 217198592 22:02:05 INFO - PID 26665 | 22:02:06 INFO - PID 26665 | Cycle 1(1): loaded http://localhost:57878/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57878/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:02:07 INFO - PID 26665 | RSS: Main: 217100288 22:02:07 INFO - PID 26665 | 22:02:09 INFO - PID 26665 | Cycle 1(1): loaded http://localhost:57878/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57878/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:02:09 INFO - PID 26665 | RSS: Main: 215449600 22:02:09 INFO - PID 26665 | 22:02:12 INFO - PID 26665 | Cycle 1(1): loaded http://localhost:57878/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57878/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:02:12 INFO - PID 26665 | RSS: Main: 217407488 22:02:12 INFO - PID 26665 | 22:02:15 INFO - PID 26665 | Cycle 1(1): loaded http://localhost:57878/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57878/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:02:16 INFO - PID 26665 | RSS: Main: 216059904 22:02:16 INFO - PID 26665 | 22:02:19 INFO - PID 26665 | Cycle 1(1): loaded http://localhost:57878/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57878/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:02:20 INFO - PID 26665 | RSS: Main: 217231360 22:02:20 INFO - PID 26665 | 22:02:21 INFO - PID 26665 | Cycle 1(1): loaded http://localhost:57878/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57878/tests/kraken/driver.html?testName=ai-astar) 22:02:22 INFO - PID 26665 | RSS: Main: 219480064 22:02:22 INFO - PID 26665 | 22:02:22 INFO - PID 26665 | __start_tp_report 22:02:22 INFO - PID 26665 | _x_x_mozilla_page_load 22:02:22 INFO - PID 26665 | _x_x_mozilla_page_load_details 22:02:22 INFO - PID 26665 | |i|pagename|runs| 22:02:22 INFO - PID 26665 | |0;ai-astar;98;115;102;107;108;116;115;101;114;109 22:02:22 INFO - PID 26665 | |1;audio-beat-detection;161;126;138;190;118;142;159;125;173;121 22:02:22 INFO - PID 26665 | |2;audio-dft;164;165;166;165;168;169;180;177;164;166 22:02:22 INFO - PID 26665 | |3;audio-fft;80;75;78;175;78;76;90;100;97;83 22:02:22 INFO - PID 26665 | |4;audio-oscillator;80;84;136;85;89;85;131;80;79;130 22:02:22 INFO - PID 26665 | |5;imaging-gaussian-blur;121;115;114;114;115;121;119;118;124;115 22:02:22 INFO - PID 26665 | |6;imaging-darkroom;151;151;152;155;155;151;157;150;157;150 22:02:22 INFO - PID 26665 | |7;imaging-desaturate;97;102;94;100;102;105;101;96;101;99 22:02:22 INFO - PID 26665 | |8;json-parse-financial;58;54;53;62;54;56;59;62;53;54 22:02:22 INFO - PID 26665 | |9;json-stringify-tinderbox;62;59;60;58;63;55;60;57;62;66 22:02:22 INFO - PID 26665 | |10;stanford-crypto-aes;90;77;81;78;79;83;77;79;79;86 22:02:22 INFO - PID 26665 | |11;stanford-crypto-ccm;132;125;131;131;136;126;133;126;126;174 22:02:22 INFO - PID 26665 | |12;stanford-crypto-pbkdf2;177;173;184;188;179;178;176;181;196;190 22:02:22 INFO - PID 26665 | |13;stanford-crypto-sha256-iterative;74;66;68;66;68;75;67;69;66;67 22:02:22 INFO - PID 26665 | __end_tp_report 22:02:22 INFO - PID 26665 | __start_cc_report 22:02:22 INFO - PID 26665 | _x_x_mozilla_cycle_collect,976 22:02:22 INFO - PID 26665 | __end_cc_report 22:02:22 INFO - PID 26665 | __startTimestamp1502946142076__endTimestamp 22:02:22 INFO - PID 26665 | 22:02:22 INFO - PID 26665 | ------- Summary: start ------- 22:02:22 INFO - PID 26665 | Number of tests: 14 22:02:22 INFO - PID 26665 | 22:02:22 INFO - PID 26665 | [#0] ai-astar Cycles:10 Average:108.50 Median:114.50 stddev:6.52 (5.7%) stddev-sans-first:5.70 22:02:22 INFO - PID 26665 | Values: 98.0 115.0 102.0 107.0 108.0 116.0 115.0 101.0 114.0 109.0 22:02:22 INFO - PID 26665 | 22:02:22 INFO - PID 26665 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:150.50 stddev:24.46 (16.3%) stddev-sans-first:25.27 22:02:22 INFO - PID 26665 | Values: 161.0 126.0 138.0 190.0 118.0 142.0 159.0 125.0 173.0 121.0 22:02:22 INFO - PID 26665 | 22:02:22 INFO - PID 26665 | [#2] audio-dft Cycles:10 Average:168.40 Median:167.00 stddev:5.60 (3.4%) stddev-sans-first:5.71 22:02:22 INFO - PID 26665 | Values: 164.0 165.0 166.0 165.0 168.0 169.0 180.0 177.0 164.0 166.0 22:02:22 INFO - PID 26665 | 22:02:22 INFO - PID 26665 | [#3] audio-fft Cycles:10 Average:93.20 Median:79.00 stddev:30.05 (38.0%) stddev-sans-first:31.50 22:02:22 INFO - PID 26665 | Values: 80.0 75.0 78.0 175.0 78.0 76.0 90.0 100.0 97.0 83.0 22:02:22 INFO - PID 26665 | 22:02:22 INFO - PID 26665 | [#4] audio-oscillator Cycles:10 Average:97.90 Median:82.00 stddev:23.99 (29.3%) stddev-sans-first:24.56 22:02:22 INFO - PID 26665 | Values: 80.0 84.0 136.0 85.0 89.0 85.0 131.0 80.0 79.0 130.0 22:02:22 INFO - PID 26665 | 22:02:22 INFO - PID 26665 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.50 stddev:3.53 (3.0%) stddev-sans-first:3.53 22:02:22 INFO - PID 26665 | Values: 121.0 115.0 114.0 114.0 115.0 121.0 119.0 118.0 124.0 115.0 22:02:22 INFO - PID 26665 | 22:02:22 INFO - PID 26665 | [#6] imaging-darkroom Cycles:10 Average:152.90 Median:153.50 stddev:2.81 (1.8%) stddev-sans-first:2.89 22:02:22 INFO - PID 26665 | Values: 151.0 151.0 152.0 155.0 155.0 151.0 157.0 150.0 157.0 150.0 22:02:22 INFO - PID 26665 | 22:02:22 INFO - PID 26665 | [#7] imaging-desaturate Cycles:10 Average:99.70 Median:99.50 stddev:3.27 (3.3%) stddev-sans-first:3.32 22:02:22 INFO - PID 26665 | Values: 97.0 102.0 94.0 100.0 102.0 105.0 101.0 96.0 101.0 99.0 22:02:22 INFO - PID 26665 | 22:02:22 INFO - PID 26665 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:57.00 stddev:3.54 (6.2%) stddev-sans-first:3.71 22:02:22 INFO - PID 26665 | Values: 58.0 54.0 53.0 62.0 54.0 56.0 59.0 62.0 53.0 54.0 22:02:22 INFO - PID 26665 | 22:02:22 INFO - PID 26665 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:61.00 stddev:3.19 (5.2%) stddev-sans-first:3.32 22:02:22 INFO - PID 26665 | Values: 62.0 59.0 60.0 58.0 63.0 55.0 60.0 57.0 62.0 66.0 22:02:22 INFO - PID 26665 | 22:02:22 INFO - PID 26665 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:80.00 stddev:4.25 (5.3%) stddev-sans-first:2.98 22:02:22 INFO - PID 26665 | Values: 90.0 77.0 81.0 78.0 79.0 83.0 77.0 79.0 79.0 86.0 22:02:22 INFO - PID 26665 | 22:02:22 INFO - PID 26665 | [#11] stanford-crypto-ccm Cycles:10 Average:134.00 Median:131.50 stddev:14.53 (11.0%) stddev-sans-first:15.39 22:02:22 INFO - PID 26665 | Values: 132.0 125.0 131.0 131.0 136.0 126.0 133.0 126.0 126.0 174.0 22:02:22 INFO - PID 26665 | 22:02:22 INFO - PID 26665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.20 Median:182.50 stddev:7.21 (3.9%) stddev-sans-first:7.40 22:02:22 INFO - PID 26665 | Values: 177.0 173.0 184.0 188.0 179.0 178.0 176.0 181.0 196.0 190.0 22:02:22 INFO - PID 26665 | 22:02:22 INFO - PID 26665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.00 stddev:3.27 (4.8%) stddev-sans-first:2.83 22:02:22 INFO - PID 26665 | Values: 74.0 66.0 68.0 66.0 68.0 75.0 67.0 69.0 66.0 67.0 22:02:22 INFO - PID 26665 | -------- Summary: end -------- 22:02:22 INFO - PID 26665 | 22:02:22 INFO - PID 26665 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 22:02:23 INFO - TEST-INFO | 26665: exit 0 22:02:23 INFO - TEST-OK | kraken | took 63575ms 22:02:23 INFO - SUITE-END | took 1179s 22:02:23 INFO - Completed test suite (00:19:39) 22:02:23 INFO - javascript benchmark 22:02:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8622.37463044234, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3138.199759061439, 3144.7955882867614, 3172.8096314221143, 3180.4434224010793, 3197.9840100799493, 6141.324454310034, 6161.784337548187, 6200.565960382769, 6273.404026617475, 6302.432781049704, 6218.875622487548, 6230.28351739549, 6235.376462353763, 6260.499160067195, 6273.466755325803, 5636.436356364372, 5689.089745640698, 5700.287464066992, 5727.198192253088, 5769.278840144982, 5684.857878553049, 5701.914471282934, 5704.458076482748, 5749.683767392792, 5771.105478650816, 5666.348369937448, 5715.628484148538, 5740.827775166731, 5745.368009518949, 5752.424757524256, 5725.713714314309, 5740.9712951435395, 5742.052561327376, 5757.050086735704, 5772.6536407815665, 5624.3250809903075, 5756.251687280626, 5765.279340082489, 5769.365369809318, 5790.420957904218, 6171.228596425447, 6200.286966998808, 6244.843878903063, 6328.398802113792, 6335.5565110442285, 6546.6726663667105, 6646.833829154261, 6704.463642908556, 6755.290694477058, 6818.727250909958, 6228.22147231596, 6720.5295629305965, 6814.48891333147, 6844.623545704984, 6858.862822743517, 6260.311365749764, 6272.2159730033745, 6278.0269058296035, 6311.652859092748, 6339.36606339367, 6797.524173307821, 6900.827479313058, 6908.412784913238, 6985.057017302701, 7009.228984811667, 6512.0, 6558.409743123047, 6579.309172536815, 6581.76963806274, 6584.440322572539, 6685.331466853276, 6712.630805305657, 6733.6296503692765, 6758.7296508139125, 6768.153980752406, 6668.899966500507, 6693.866122677617, 6694.196696396463, 6700.061991321219, 6725.159355080615, 6710.127683401127, 6732.057511948331, 6756.986452032234, 6795.490338224653, 6798.2182049064, 5353.866153346197, 5401.918971215357, 5442.210879422461, 5445.0, 5449.237106805051, 4549.3176023596725, 4608.792604332813, 4634.37435946143, 4652.069586082729, 4682.250839865674, 5699.601027928005, 5709.0, 5720.227769251098, 5765.538756899438, 5765.567582431335, 6688.963210702349, 6734.696938637773, 6756.560823546453, 6757.662116894234, 6768.627725475146, 5744.942550574524, 5820.679862607597, 5831.0, 5834.008218602848, 5845.0, 5761.971190144022, 5869.295684517885, 5884.293884733859, 5902.61632993854, 5966.284045914518, 6506.0, 6509.2839787623325, 6510.707018184193, 6515.087887695727, 6530.0, 6649.60102393858, 6655.267920528738, 6682.866342673216, 6685.799426017227, 6692.966535167293, 6341.143945567474, 6484.416402523795, 6515.543911926309, 6574.8356291093105, 6645.667716614246, 6522.21733391996, 6602.867942641216, 6607.933920660732, 6646.83382915431, 6726.7981960541265, 6762.695678694372, 6774.8645027100165, 6800.115984921928, 6810.0, 6811.591304521745, 6476.902846457401, 6489.415952564292, 6559.245686746085, 6574.342565743579, 6582.440492558187, 5447.4824891635235, 6503.382178693017, 6516.283208846929, 6516.73933042673, 6617.7683781067435, 6449.258335291313, 6452.709628066842, 6530.314316996837, 6546.345365463416, 6569.901451478136, 6459.903101453576, 6613.107230523818, 6615.4376877965915, 6626.370494802986, 6715.093462382712, 6267.62394256346, 6366.204224471941, 6401.967990160019, 6409.327020662763, 6431.356864313531], "value": 6112.766680787474, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [813.9470934389265, 822.7408366364598, 848.7496188624356, 873.7597160780784, 875.8773771671963, 39566.802165989204, 40448.59551404485, 40517.594824051754, 40663.59336406642, 40704.0, 36388.45417318743, 36523.0, 36621.63378366215, 36890.63109368906, 37055.44416833743, 6759.526833121671, 6859.485538584601, 6879.036934829128, 6885.896711549306, 6888.483363747714, 6698.1292431983775, 6783.253842077367, 6786.558873673195, 6794.252632210453, 6798.626075565842, 7305.196428392873, 7467.402607791364, 7487.513311634726, 7498.100227972651, 7517.36102431294, 7406.666699998513, 7415.961765352828, 7460.14208366034, 7471.215522370155, 7471.887921681152, 7328.120625524918, 7380.520266182734, 7400.333969942677, 7442.404607631376, 7565.319121279056, 38295.42556861649, 38708.45166193349, 38805.41791873124, 38903.0, 38938.221235575416, 3532.788032718045, 3574.6425357464304, 3577.588577313616, 3580.230250496156, 3580.480830279595, 30435.23911902198, 30538.54192187119, 30586.0, 30645.233869153228, 30671.38657226843, 5012.348394708664, 5033.748312584356, 5035.269885866529, 5036.395632524121, 5055.292259083732, 222347.0, 222779.0, 225924.0, 226914.0, 227332.99999999834, 48109.0, 48591.0, 48603.27095093577, 48805.26792098051, 49055.75472122616, 50892.236616450784, 50946.74526627343, 51020.23469647958, 51140.23289650658, 51173.929564226266, 16346.836531634532, 16387.754183687255, 16668.41660541875, 16712.916435417745, 16747.330106795835, 13044.804327935088, 13372.33138343079, 13672.0, 13725.656858578615, 13798.0, 14530.128192308495, 14638.414463421557, 14834.406623735145, 14914.850851491563, 15026.69946601062, 5838.4453476919625, 6149.600275982047, 6176.752929882844, 6197.183098591496, 6203.875922481525, 1005.1406047829147, 1025.2771795883884, 1031.9690409287734, 1035.1822060572215, 1050.3172937590627, 23004.0, 23325.53348933012, 23355.88322058379, 23471.53056938886, 23546.529069418517, 1122.7586068995042, 1133.8582677165355, 1142.8400023996646, 1146.4210573660414, 1159.2059439284117, 12427.627171184879, 12453.501859925502, 12494.937525312314, 12497.18768280059, 12551.811722824164, 237753.0, 237764.0, 238152.0, 238346.0, 238495.0, 44623.0, 45718.542814571425, 45795.77102114468, 51976.22035669468, 52251.0, 1480.726065677853, 1481.15574122749, 1484.161448781435, 1485.5469081930114, 1485.947991820281, 28114.0, 28275.71724282813, 28421.715782841908, 28486.0, 29156.0, 37058.25883482369, 50841.49158508368, 51953.0, 52023.479765203374, 52115.21827172671, 209226.0, 210482.0, 211463.0, 211935.0, 213046.0, 36074.63925360818, 36354.0, 36429.0, 36462.63537364698, 36492.635073648926, 43093.35359969666, 44652.106957860015, 44901.55098449104, 44971.32543011792, 45364.31953520766, 32652.83673581617, 32735.83632081824, 33323.83338083294, 33537.16157096092, 33800.49299260464, 32285.35429291354, 32428.513572295964, 32766.34467310688, 34252.31495370129, 35779.46330804988, 36975.260494789414, 37381.0, 37685.81157094197, 37759.244815104095, 37765.4335184978, 32118.0, 32447.35105297928, 34248.82875585706, 34400.655993439745, 34578.30843383068, 24707.62938555959, 24910.875445622656, 25334.493310133326, 25803.0, 25826.504097541325], "value": 17506.972106315803, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.1308758336994, 579.7854793726319, 584.6199970019484, 585.4379795396419, 590.1177739279777, 22483.662745058817, 23200.0, 23286.65070023951, 23289.534209315803, 23293.767062329393, 25418.11036613719, 27529.724702752967, 27730.02944896929, 27985.440291194165, 27987.160385188476, 7038.718451261943, 7130.893036604455, 7149.7497587584185, 7203.855922881539, 7206.027186329831, 6564.179477565304, 6875.106236189288, 7079.64601769912, 7104.68028938699, 7158.248383919691, 6822.215445223788, 6834.179898412198, 6838.965805170992, 6845.931540684579, 6847.965760171217, 6783.3216678332265, 6805.693743781541, 6841.726330946756, 6846.794596162098, 6847.383735463807, 6659.03444000622, 6683.2982536833415, 6694.297098804653, 6700.932990670129, 6701.329867013308, 30409.69590304091, 31585.21036974094, 31672.841635791672, 31838.681613184035, 32070.0, 1913.540750219937, 1935.4387227703949, 1944.7374604428362, 1953.4725624081418, 1957.725918371429, 20005.29981450657, 21166.153353865826, 21180.470488237763, 21272.680909786366, 21447.8927605361, 2530.329462692388, 2548.604966230237, 2644.854533000684, 2651.787856971457, 2652.2175958092407, 143804.0, 146657.0, 147760.52239477576, 148027.0, 148277.0, 19968.90015549913, 21314.573708525742, 22373.664395034088, 22532.662010069864, 23224.4193895154, 44388.77805610951, 44653.55346446494, 44696.3295550567, 44716.77641611771, 44959.55040449619, 11390.145739069438, 11715.76568468626, 11808.70478238051, 11936.28382297065, 12039.157258991787, 9790.951045244728, 9834.065763752433, 9870.950645246729, 10069.144122749649, 10112.949435252776, 8853.46879187238, 9204.171624553823, 9246.722598322061, 9444.90555094454, 11092.223544351818, 2607.76530112287, 2674.772644325254, 2683.8196736866876, 2703.9729602704115, 2727.440874620698, 944.9385789923771, 975.6487664440796, 985.103555764251, 995.144176008632, 998.605550807427, 19464.513387165433, 19650.21399144018, 19944.70082948757, 19952.20191192336, 24377.0, 1055.176961969665, 1070.4915165296577, 1074.5003573338436, 1083.1226706367868, 1087.472575800736, 11289.435528223556, 11623.88376116245, 11689.18175727708, 11707.824382634268, 11778.175527713149, 549761.0, 556724.0, 563400.0, 565109.0, 567529.0, 116587.0, 119587.0, 120224.0, 120666.38000859988, 123380.0, 1250.93745312734, 1281.8910392616544, 1284.7494738526084, 1299.4412402666944, 1301.4078594239597, 18325.175367108244, 18385.0, 18494.537636559195, 18609.69732118739, 18897.716534251722, 56898.0, 57160.42839571551, 57849.0, 60163.69918150381, 60402.69798650979, 71533.0, 71977.0, 72230.0, 72303.63848180725, 73610.0, 11912.463939122934, 12250.448729807002, 13009.284489353176, 14378.856211437751, 14652.19412932299, 22239.332820015425, 22457.101715931833, 22549.098036078372, 23094.307170784905, 23397.298081057597, 18358.265669373075, 18460.261589536807, 18490.907545462724, 18494.907525462826, 18603.255869765057, 15875.364985400454, 16054.759178612096, 16592.585185370463, 17283.395081172097, 17492.82507174912, 18736.718949216047, 18899.527511812314, 19054.523636909187, 19213.135408906353, 19301.517462063563, 14245.430182792572, 14701.264936753334, 14716.705665886408, 14964.700705985602, 14966.625834354229, 17000.404985825437, 17202.483925482255, 18877.811221888154, 19098.0, 19206.0], "value": 12772.891591503723, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1301.6550614087266, 1378.2832926878018, 1384.377030336349, 1393.2128347483672, 1401.964950876228, 13930.164190148598, 14513.49202777903, 14597.70804583909, 14660.926695366508, 14693.853061469383, 12236.26582405054, 12712.173708708928, 12731.108822382437, 13635.113717608348, 14095.71808563828, 2644.074573899139, 2719.1978366381963, 2736.9589456158174, 2743.9588406173825, 2748.6014527893444, 2660.948925174555, 2682.825616334942, 2706.269307287031, 2714.4164004738977, 2716.144414509433, 2607.413332000304, 2801.1876555798794, 2807.03157410693, 2809.2836326736656, 2810.1990932584217, 2749.505089083964, 2755.476459472694, 2767.778577713778, 2769.62610047645, 2786.5680819473114, 2719.279390961397, 2725.0870958229016, 2726.2502811726736, 2756.8483733394655, 2759.3377589378406, 14055.156690598596, 14315.0, 14404.423823047066, 14432.567022989328, 14446.855531444657, 7562.168161502231, 7861.21387861215, 7891.131975482693, 7907.44647874649, 7936.246056624669, 5051.6716413433005, 5083.262926875583, 5196.53231209193, 5279.128943724281, 5280.973595132, 1857.182839550607, 1894.5358387195088, 1902.3531999120228, 1918.7313776071362, 1922.5770330527262, 23633.7636623635, 24218.39454013646, 24354.63468047981, 24410.267691969268, 24459.143929962545, 6687.866242675216, 6898.206706228748, 6929.68816403253, 7125.714971401086, 7148.428125749928, 19173.424797256106, 19234.615307693766, 19319.22723091089, 19327.0, 19339.613207735765, 7786.532808031537, 7834.569098699512, 7933.404994625426, 8143.307818835347, 8170.509769413854, 7183.06620139389, 7230.602316872517, 7297.671604777798, 7298.890516642255, 7327.706891724378, 5096.694198348111, 5218.8956220876125, 5266.2890509781455, 5270.552003079782, 5300.35688936431, 1326.316946772413, 1342.2080972226433, 1500.7298686236363, 1514.2050423527517, 1520.429838810446, 875.8248350329959, 882.1090698394668, 896.1531352871474, 901.8151278987923, 911.7538264668635, 8699.695510657224, 8872.512011839282, 8969.865452018224, 8980.595873185723, 9049.547522623843, 955.7371722776153, 957.9712608621752, 970.7042843674659, 971.6016433262329, 998.7053819123377, 5375.75809088592, 5401.4868587484125, 5412.377576578665, 5414.18787181918, 5608.158776183605, 19254.0, 20118.899405502878, 20170.69743953842, 20223.898880505505, 20309.390718278475, 17014.829851701572, 19764.90117549403, 19830.107645156004, 19928.402147935583, 20103.698444523343, 11027.283226590245, 11075.280106793032, 11312.773744525064, 11313.886861131448, 11361.829572556418, 8283.337333013465, 8476.49141051539, 8690.608922598372, 8741.519216442903, 8836.293096552388, 16465.83534164643, 16778.832211677727, 16977.0, 17035.31858725637, 17071.487855364358, 16113.597160071093, 17122.229499672794, 17253.13734313254, 17303.91348043252, 17715.114244287994, 11700.765984680089, 11748.412579370826, 12021.519139234333, 12037.75924481523, 12065.336406497376, 13413.0, 13662.863371366557, 13683.589492315246, 13701.520446784314, 13718.245496497788, 10913.508892100033, 11130.443477825915, 11195.888041119484, 11267.492962816528, 11614.535418583162, 10797.190210734068, 10859.457027148768, 10934.671959841218, 11314.434278285888, 11320.207585468937, 9673.516324183904, 9766.75583110428, 9778.462184579916, 9822.066903644143, 9827.213822894295, 7206.351428371472, 7262.564246145248, 7344.632768361454, 7351.154617219088, 7366.558006519626, 7419.629018548943, 7452.993845830743, 7521.398288137046, 7521.548707077593, 7567.659455324634], "value": 6592.6897424018925, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [476.4378033919973, 495.50547962073637, 512.2546694559417, 516.7287174233525, 519.5116590405019, 6102.206713127298, 6180.351063138373, 6190.473809726167, 6234.882558720639, 6241.875162496747, 5956.404359564041, 6062.727177277022, 6065.181200537926, 6066.0, 6090.421409966058, 4854.349521162804, 4856.198727210006, 4884.291777692232, 4939.851804445854, 4963.950360496385, 4884.508900460773, 4960.206366981283, 4969.652124351297, 4973.3286006389035, 4997.001199520185, 4711.481737008926, 4870.512948705119, 4886.975565122169, 4890.633202509826, 4944.777485013183, 4839.483468596311, 4878.4145902491755, 4904.901901961976, 4920.384951881015, 4942.3327850740225, 4348.651917905428, 4360.21516127097, 4380.255356589356, 4395.780210989437, 4400.713953593038, 5928.7332070056955, 5930.55520835939, 5941.732622032019, 5977.133315669247, 5985.371535988702, 5623.746931388097, 5641.266635337421, 5652.0, 5663.575231857627, 5718.170865224561, 6472.935270647327, 6527.412532872065, 6532.7713530026695, 6540.234136783042, 6556.18047744032, 4782.52174782519, 4794.592459640935, 4811.975940120312, 4823.324734537167, 4872.0499502597, 6870.416014638762, 6877.965610171917, 6911.7926462206215, 6966.442684585221, 6993.860122797567, 4951.752412379366, 4962.131626965339, 4962.206047032458, 4968.180250258667, 4980.526849949249, 4986.556587272211, 4992.530191516861, 5002.699838009731, 5011.924821127686, 5066.797328106908, 5589.441055894378, 5633.732410207671, 5640.351359593617, 5671.886562268732, 5728.369879313273, 6464.967675161688, 6533.281339052701, 6555.508336874754, 6557.573757705733, 6599.868002639921, 1649.7030534503904, 1737.9826201738074, 1745.3542189389752, 1760.8679349048616, 1761.5243884151464, 1110.3227031510771, 1169.6140273709655, 1187.857457105153, 1195.964121076369, 1211.4366819429008, 5609.971950140223, 5634.323881134208, 5667.1499275108235, 5671.546276297886, 5687.521244476383, 6519.608823470607, 6552.279249282575, 6555.704993275314, 6593.703283352261, 6705.2624211336715, 5620.325560932714, 5654.208410822488, 5679.0, 5690.943090569124, 5718.513926316226, 3504.5093686883856, 3518.3491054155065, 3539.9292014159573, 3549.94675079874, 3561.0, 6357.237131544244, 6424.229092508929, 6432.871342573122, 6433.967830160819, 6442.516811239176, 6655.633940133339, 6696.46428285736, 6736.865262694719, 6743.831404214836, 6800.557963732342, 6403.615783053032, 6403.839904002437, 6459.224893012869, 6476.902846457401, 6507.804765857032, 6597.119820851034, 6598.835029124119, 6625.900611490928, 6629.7348106075215, 6633.3035031321015, 6514.478841692748, 6574.80275591733, 6622.536422450382, 6658.234303055211, 6683.465322774264, 6399.488040956805, 6424.871502569829, 6454.128692626436, 6454.160959075478, 6470.741170353133, 4938.555530002317, 4940.333055037668, 4972.9254061188385, 4973.726445045557, 5006.299118123538, 6551.279359270381, 6561.901571476527, 6576.934230657632, 6586.736530538725, 6692.933070669231, 6237.407446292595, 6311.368863113836, 6345.1434056401795, 6398.424141827071, 6438.871222575616, 6353.1893410377825, 6395.345931438401, 6423.582467139621, 6453.386928241809, 6470.417662410406, 5903.321118071477, 6223.751049957951, 6283.2460104787715, 6336.320874968229, 6386.9680651596445, 6439.195100612424, 6542.855000375011, 6565.573237739532, 6596.317938925543, 6597.3072827352435, 6240.344763799917, 6261.812145635638, 6299.275583307978, 6335.176427064452, 6360.204974378203], "value": 4986.3101399376255, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [858.7724253072932, 888.6756333938115, 903.5075883643414, 907.0566610724845, 915.208344781764, 18831.0, 19292.131854066567, 19306.613867722637, 19410.51473713158, 19571.0, 14855.702885942275, 15710.057396556185, 15784.21078946051, 20076.0, 20157.59684806303, 1027.835546312592, 1044.2011860926398, 1045.2683121814723, 1046.879608844985, 1055.0135623192302, 1052.3054783842665, 1053.978920421591, 1055.5250137438145, 1056.3028401255174, 1061.633736360958, 1057.5346847387164, 1101.3061771084247, 1109.7003808971572, 1113.6547670222258, 1117.932924024557, 1089.8746644135947, 1099.5217080569978, 1101.763120929, 1104.6685994201787, 1114.025227925565, 795.1849354411717, 796.0646240667251, 800.2797482265948, 806.0810675829559, 809.8299357135008, 18783.0, 19011.239550417966, 19023.80976190248, 19089.713654295196, 20635.48411289715, 22167.44581385462, 22332.776672233394, 22444.55110897773, 22565.210217642303, 22852.542949140923, 15466.0, 15890.52328430149, 16077.356905723756, 16147.03117812935, 16252.431164909289, 3469.323481921001, 3495.5805303363504, 3502.579690437138, 3515.9296814063578, 3523.2953409317984, 125095.0, 126789.36605316914, 127130.3643481786, 127613.99999999907, 130539.34730326383, 14815.703685926437, 14885.33016014282, 15030.09819410817, 15279.541613751606, 15342.309596068204, 27036.459270814867, 27215.591766123525, 27400.177994660193, 27463.313417164733, 27489.31276718098, 8698.913010869937, 8848.955755221183, 8913.24237439812, 8923.776905577413, 8946.0, 3882.281777871103, 3964.8215830287704, 3964.980175099106, 3967.305721498726, 3979.721419500665, 5103.668261562986, 5792.391798861143, 6012.789552365646, 6048.818535443944, 6064.363241859542, 1028.6554004408458, 1072.3940973350032, 1073.382804887193, 1080.2654195147375, 1083.0577397664083, 671.3152584364019, 685.5578152091873, 698.8078278473461, 704.6828926982878, 708.5571517801374, 11424.828627570592, 12012.63962081139, 12016.09879259059, 12172.57395991136, 14269.85730142706, 700.6776882634045, 703.736098962889, 709.3651182191909, 717.7165019817143, 727.2618292433184, 5688.317401911797, 5728.828135155952, 5982.880342393128, 5993.4905533029305, 6085.056816193497, 107229.0, 109795.0, 110815.44592276987, 114492.42753786177, 115435.42282288703, 93026.53486732523, 93301.53349233346, 94606.0, 96433.51783241039, 96800.51599741956, 83466.58266708627, 83833.58083209545, 87289.56355218183, 87533.56233218792, 87766.56116719503, 12518.311492867979, 12751.744965100832, 12867.099303048697, 12988.350582471028, 12994.805077924028, 39717.40423893586, 40154.0, 41722.79138604409, 41949.580504194564, 42260.78869605633, 51094.48905511046, 51232.0, 52476.47523524868, 52683.47316526939, 53466.0, 18430.078496074875, 18670.253189872252, 18974.810251897856, 19037.238510459425, 19090.809091908905, 19727.11227994715, 19782.50543736418, 19892.90053549723, 19941.60116797685, 19980.50048748793, 18960.146793394055, 19003.524911877314, 19191.424257272305, 19210.039498025322, 19504.414867553995, 18176.636467270844, 19037.619247615246, 19239.134238959, 19680.507987300432, 19956.50108747235, 17313.826861731726, 17657.646847063243, 17794.288228470716, 17961.461156165336, 18155.36456224026, 12708.618741437771, 13414.597562073153, 13893.374798133906, 14129.576112716635, 14700.926495367456, 14259.572212833631, 14423.8460923128, 14799.556013319618, 14991.925040375165, 15059.924700376429], "value": 9144.357896907675, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1565.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 115.0, 102.0, 107.0, 108.0, 116.0, 115.0, 101.0, 114.0, 109.0], "value": 108.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 126.0, 138.0, 190.0, 118.0, 142.0, 159.0, 125.0, 173.0, 121.0], "value": 145.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 166.0, 165.0, 168.0, 169.0, 180.0, 177.0, 164.0, 166.0], "value": 168.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 75.0, 78.0, 175.0, 78.0, 76.0, 90.0, 100.0, 97.0, 83.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 84.0, 136.0, 85.0, 89.0, 85.0, 131.0, 80.0, 79.0, 130.0], "value": 97.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 115.0, 114.0, 114.0, 115.0, 121.0, 119.0, 118.0, 124.0, 115.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 152.0, 155.0, 155.0, 151.0, 157.0, 150.0, 157.0, 150.0], "value": 152.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 102.0, 94.0, 100.0, 102.0, 105.0, 101.0, 96.0, 101.0, 99.0], "value": 99.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 54.0, 53.0, 62.0, 54.0, 56.0, 59.0, 62.0, 53.0, 54.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 59.0, 60.0, 58.0, 63.0, 55.0, 60.0, 57.0, 62.0, 66.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 77.0, 81.0, 78.0, 79.0, 83.0, 77.0, 79.0, 79.0, 86.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 125.0, 131.0, 131.0, 136.0, 126.0, 133.0, 126.0, 126.0, 174.0], "value": 134.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 173.0, 184.0, 188.0, 179.0, 178.0, 176.0, 181.0, 196.0, 190.0], "value": 182.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 66.0, 68.0, 66.0, 68.0, 75.0, 67.0, 69.0, 66.0, 67.0], "value": 68.6, "unit": "score"}]}]} 22:02:23 INFO - Return code: 0 22:02:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:02:23 INFO - # TBPL SUCCESS # 22:02:23 INFO - Running post-action listener: _package_coverage_data 22:02:23 INFO - Running post-action listener: _resource_record_post_action 22:02:23 INFO - [mozharness: 2017-08-17 05:02:23.390732Z] Finished run-tests step (success) 22:02:23 INFO - Running post-run listener: _resource_record_post_run 22:02:23 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 428740608; Read time: 12; Write time: 292012 22:02:23 INFO - TinderboxPrint: CPU usage
13.3% 22:02:23 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 22:02:23 INFO - TinderboxPrint: I/O write bytes / time
428,740,608 / 292,012 22:02:23 INFO - TinderboxPrint: CPU idle
8,279.3 (86.7%) 22:02:23 INFO - TinderboxPrint: CPU user
1,210.1 (12.7%) 22:02:23 INFO - TinderboxPrint: Swap in / out
0 / 0 22:02:23 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107307008; Read time: 0; Write time: 94828 22:02:23 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 22:02:23 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 321433600; Read time: 0; Write time: 197184 22:02:24 INFO - Running post-run listener: _upload_blobber_files 22:02:24 INFO - Blob upload gear active. 22:02:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:02:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:02:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:02:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:02:24 INFO - (blobuploader) - INFO - Open directory for files ... 22:02:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:02:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:02:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:02:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:02:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:02:25 INFO - (blobuploader) - INFO - Done attempting. 22:02:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:02:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:02:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:02:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:02:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:02:32 INFO - (blobuploader) - INFO - Done attempting. 22:02:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:02:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:02:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:02:32 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:02:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:02:32 INFO - (blobuploader) - INFO - Done attempting. 22:02:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:02:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:02:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:02:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:02:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:02:33 INFO - (blobuploader) - INFO - Done attempting. 22:02:33 INFO - (blobuploader) - INFO - Iteration through files over. 22:02:33 INFO - Return code: 0 22:02:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:02:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:02:33 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/625a4543a3a232e23c121b5f58faf9cf0bfae8da34e24c490dc895f7f1947a1e050c6c68c1820bef19617aae604aae38e811c2c48b7e9944fbfdbee0cd520d61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e619519bfc7ea5059b7dd0ae3fa0f0f47b4c7b1c0098f19fcfadb195166e41117c5370f587ac630f6554b1b87c9c58f91eac3c6637b07709d20f0d15cbb9d8fb", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61961609bb51ba488a9680f1610f9ca73c9ec1477a3469834710ce1bdf2154f1d42bb6d181a276d59283d302838eed9e380e0557b3ee6336a8b0a3e8977f1a1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c42cd75fef341f55e112cc50a75a02511a9901ac1c55737ebf987b1af182f9dc57d2294c6e8202839629262ffb6876697fbbfb1417202ef0729477c5638e97f"} 22:02:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:02:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:02:33 INFO - Contents: 22:02:33 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/625a4543a3a232e23c121b5f58faf9cf0bfae8da34e24c490dc895f7f1947a1e050c6c68c1820bef19617aae604aae38e811c2c48b7e9944fbfdbee0cd520d61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e619519bfc7ea5059b7dd0ae3fa0f0f47b4c7b1c0098f19fcfadb195166e41117c5370f587ac630f6554b1b87c9c58f91eac3c6637b07709d20f0d15cbb9d8fb", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61961609bb51ba488a9680f1610f9ca73c9ec1477a3469834710ce1bdf2154f1d42bb6d181a276d59283d302838eed9e380e0557b3ee6336a8b0a3e8977f1a1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c42cd75fef341f55e112cc50a75a02511a9901ac1c55737ebf987b1af182f9dc57d2294c6e8202839629262ffb6876697fbbfb1417202ef0729477c5638e97f"} 22:02:33 INFO - Running post-run listener: copy_logs_to_upload_dir 22:02:33 INFO - Copying logs to upload dir... 22:02:33 INFO - mkdir: /builds/slave/test/build/upload/logs 22:02:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.115984 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-08-16 22:02:33.342419) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 22:02:33.349484) ========= 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=20e666a3d4cfbb71505a330e000001b4-1502936562.113536-1093056980 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/625a4543a3a232e23c121b5f58faf9cf0bfae8da34e24c490dc895f7f1947a1e050c6c68c1820bef19617aae604aae38e811c2c48b7e9944fbfdbee0cd520d61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e619519bfc7ea5059b7dd0ae3fa0f0f47b4c7b1c0098f19fcfadb195166e41117c5370f587ac630f6554b1b87c9c58f91eac3c6637b07709d20f0d15cbb9d8fb", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61961609bb51ba488a9680f1610f9ca73c9ec1477a3469834710ce1bdf2154f1d42bb6d181a276d59283d302838eed9e380e0557b3ee6336a8b0a3e8977f1a1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c42cd75fef341f55e112cc50a75a02511a9901ac1c55737ebf987b1af182f9dc57d2294c6e8202839629262ffb6876697fbbfb1417202ef0729477c5638e97f"} build_url:https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011202 build_url: 'https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/625a4543a3a232e23c121b5f58faf9cf0bfae8da34e24c490dc895f7f1947a1e050c6c68c1820bef19617aae604aae38e811c2c48b7e9944fbfdbee0cd520d61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e619519bfc7ea5059b7dd0ae3fa0f0f47b4c7b1c0098f19fcfadb195166e41117c5370f587ac630f6554b1b87c9c58f91eac3c6637b07709d20f0d15cbb9d8fb", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61961609bb51ba488a9680f1610f9ca73c9ec1477a3469834710ce1bdf2154f1d42bb6d181a276d59283d302838eed9e380e0557b3ee6336a8b0a3e8977f1a1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c42cd75fef341f55e112cc50a75a02511a9901ac1c55737ebf987b1af182f9dc57d2294c6e8202839629262ffb6876697fbbfb1417202ef0729477c5638e97f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 22:02:33.379585) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 22:02:33.379939) ========= 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=20e666a3d4cfbb71505a330e000001b4-1502936562.113536-1093056980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004431 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 22:02:33.435973) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 22:02:33.436320) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 22:02:33.436625) ========= ========= Total master_lag: 0.19 =========