builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-042 starttime: 1500483687.48 results: success (0) revision: 4b32e7ce740eaf6434180bc9e44731dab0aa67cc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-19 10:01:27.476261) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-19 10:01:27.476755) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-19 10:01:27.477320) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-19 10:01:27.494040) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-19 10:01:27.494427) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1500483085.397713-196695689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-19 10:01:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.6M=0s 2017-07-19 10:01:28 (45.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.366165 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-19 10:01:27.874319) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-19 10:01:27.874664) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1500483085.397713-196695689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014464 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-19 10:01:27.924179) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-19 10:01:27.924536) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4b32e7ce740eaf6434180bc9e44731dab0aa67cc --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 4b32e7ce740eaf6434180bc9e44731dab0aa67cc --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=74d6aec007b0fa31a864ebd7000001f8-1500483085.397713-196695689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-19 10:01:28,959 truncating revision to first 12 chars 2017-07-19 10:01:28,959 Setting DEBUG logging. 2017-07-19 10:01:28,959 attempt 1/10 2017-07-19 10:01:28,959 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4b32e7ce740e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-19 10:01:30,086 unpacking tar archive at: mozilla-central-4b32e7ce740e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.501553 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-19 10:01:29.439328) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-19 10:01:29.439650) ========= script_repo_revision: 4b32e7ce740eaf6434180bc9e44731dab0aa67cc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-19 10:01:29.440030) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-19 10:01:29.440345) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-19 10:01:29.450815) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-07-19 10:01:29.451080) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=74d6aec007b0fa31a864ebd7000001f8-1500483085.397713-196695689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:01:30 INFO - MultiFileLogger online at 20170719 10:01:30 in /builds/slave/test 10:01:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 10:01:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:01:30 INFO - {'append_to_log': False, 10:01:30 INFO - 'base_work_dir': '/builds/slave/test', 10:01:30 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 10:01:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:01:30 INFO - 'branch': 'Firefox-Non-PGO', 10:01:30 INFO - 'buildbot_json_path': 'buildprops.json', 10:01:30 INFO - 'code_coverage': False, 10:01:30 INFO - 'config_files': ('talos/linux_config.py',), 10:01:30 INFO - 'default_actions': ('clobber', 10:01:30 INFO - 'read-buildbot-config', 10:01:30 INFO - 'download-and-extract', 10:01:30 INFO - 'populate-webroot', 10:01:30 INFO - 'create-virtualenv', 10:01:30 INFO - 'install', 10:01:30 INFO - 'setup-mitmproxy', 10:01:30 INFO - 'run-tests'), 10:01:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:01:30 INFO - 'disable_ccov_upload': False, 10:01:30 INFO - 'download_minidump_stackwalk': True, 10:01:30 INFO - 'download_symbols': 'ondemand', 10:01:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:01:30 INFO - 'tooltool.py': '/tools/tooltool.py', 10:01:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:01:30 INFO - '/tools/misc-python/virtualenv.py')}, 10:01:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:01:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:01:30 INFO - 'gecko_profile': False, 10:01:30 INFO - 'gecko_profile_interval': 0, 10:01:30 INFO - 'installer_path': 'installer.exe', 10:01:30 INFO - 'log_level': 'info', 10:01:30 INFO - 'log_name': 'talos', 10:01:30 INFO - 'log_to_console': True, 10:01:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:01:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:01:30 INFO - 'opt_config_files': (), 10:01:30 INFO - 'pip_index': False, 10:01:30 INFO - 'suite': 'dromaeojs-e10s', 10:01:30 INFO - 'system_bits': '32', 10:01:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:01:30 INFO - 'title': 'talos-linux64-ix-042', 10:01:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:01:30 INFO - 'use_talos_json': True, 10:01:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:01:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:01:30 INFO - 'work_dir': 'build'} 10:01:30 INFO - [mozharness: 2017-07-19 17:01:30.586651Z] Running clobber step. 10:01:30 INFO - Running pre-action listener: _resource_record_pre_action 10:01:30 INFO - Running main action method: clobber 10:01:30 INFO - rmtree: /builds/slave/test/build 10:01:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:01:31 INFO - Running post-action listener: _resource_record_post_action 10:01:31 INFO - [mozharness: 2017-07-19 17:01:31.624765Z] Finished clobber step (success) 10:01:31 INFO - [mozharness: 2017-07-19 17:01:31.624868Z] Running read-buildbot-config step. 10:01:31 INFO - Running pre-action listener: _resource_record_pre_action 10:01:31 INFO - Running main action method: read_buildbot_config 10:01:31 INFO - Using buildbot properties: 10:01:31 INFO - { 10:01:31 INFO - "project": "", 10:01:31 INFO - "product": "firefox", 10:01:31 INFO - "who": "ffxbld@noreply.mozilla.org", 10:01:31 INFO - "installer_path": "public/build/target.tar.bz2", 10:01:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 10:01:31 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 10:01:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 10:01:31 INFO - "stage_platform": "linux64", 10:01:31 INFO - "basedir": "/builds/slave/test", 10:01:31 INFO - "buildnumber": 1019, 10:01:31 INFO - "platform": "ubuntu64_hw", 10:01:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:01:31 INFO - "slavebuilddir": "test", 10:01:31 INFO - "taskId": "HrQrYcATSc6PDfk0Bykj4A", 10:01:31 INFO - "branch": "mozilla-central", 10:01:31 INFO - "script_repo_revision": "production", 10:01:31 INFO - "revision": "4b32e7ce740eaf6434180bc9e44731dab0aa67cc", 10:01:31 INFO - "slavename": "talos-linux64-ix-042", 10:01:31 INFO - "repo_path": "mozilla-central" 10:01:31 INFO - } 10:01:31 INFO - Finding installer, test and symbols from parent task. 10:01:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HrQrYcATSc6PDfk0Bykj4A'}, attempt #1 10:01:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HrQrYcATSc6PDfk0Bykj4A'}, attempt #1 10:01:32 INFO - Task dependencies: VQi_Zdf1Sr2fiUb0MKC7jg 10:01:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VQi_Zdf1Sr2fiUb0MKC7jg'}, attempt #1 10:01:33 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/VQi_Zdf1Sr2fiUb0MKC7jg/artifacts/public/build/target.tar.bz2 10:01:33 INFO - Set test_url: https://queue.taskcluster.net/v1/task/VQi_Zdf1Sr2fiUb0MKC7jg/artifacts/public/build/test_packages.json 10:01:33 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/VQi_Zdf1Sr2fiUb0MKC7jg/artifacts/public/build/target.crashreporter-symbols.zip 10:01:33 INFO - Running post-action listener: _resource_record_post_action 10:01:33 INFO - [mozharness: 2017-07-19 17:01:33.017642Z] Finished read-buildbot-config step (success) 10:01:33 INFO - [mozharness: 2017-07-19 17:01:33.017862Z] Running download-and-extract step. 10:01:33 INFO - Running pre-action listener: _resource_record_pre_action 10:01:33 INFO - Running main action method: download_and_extract 10:01:33 INFO - mkdir: /builds/slave/test/build/tests 10:01:33 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')]} 10:01:33 INFO - trying https://queue.taskcluster.net/v1/task/VQi_Zdf1Sr2fiUb0MKC7jg/artifacts/public/build/target.test_packages.json 10:01:33 INFO - Downloading https://queue.taskcluster.net/v1/task/VQi_Zdf1Sr2fiUb0MKC7jg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:01:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VQi_Zdf1Sr2fiUb0MKC7jg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:01:33 INFO - Downloaded 989 bytes. 10:01:33 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:01:33 INFO - Using the following test package requirements: 10:01:33 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:01:33 INFO - u'common': [u'target.common.tests.zip'], 10:01:33 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:01:33 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:01:33 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:01:33 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:01:33 INFO - u'mozbase': [u'target.common.tests.zip'], 10:01:33 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:01:33 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:01:33 INFO - u'web-platform': [u'target.common.tests.zip', 10:01:33 INFO - u'target.web-platform.tests.tar.gz'], 10:01:33 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:01:33 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:01:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VQi_Zdf1Sr2fiUb0MKC7jg/artifacts/public/build/target.common.tests.zip 10:01:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VQi_Zdf1Sr2fiUb0MKC7jg/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:01:33 INFO - Fetch https://queue.taskcluster.net/v1/task/VQi_Zdf1Sr2fiUb0MKC7jg/artifacts/public/build/target.common.tests.zip into memory 10:01:34 INFO - Content-Length response header: 72758579 10:01:34 INFO - Bytes received: 72758579 10:01:45 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:01:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VQi_Zdf1Sr2fiUb0MKC7jg/artifacts/public/build/target.common.tests.zip 10:01:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VQi_Zdf1Sr2fiUb0MKC7jg/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:01:45 INFO - Fetch https://queue.taskcluster.net/v1/task/VQi_Zdf1Sr2fiUb0MKC7jg/artifacts/public/build/target.common.tests.zip into memory 10:01:47 INFO - Content-Length response header: 72758579 10:01:47 INFO - Bytes received: 72758579 10:01:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VQi_Zdf1Sr2fiUb0MKC7jg/artifacts/public/build/target.talos.tests.zip 10:01:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VQi_Zdf1Sr2fiUb0MKC7jg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:01:59 INFO - Fetch https://queue.taskcluster.net/v1/task/VQi_Zdf1Sr2fiUb0MKC7jg/artifacts/public/build/target.talos.tests.zip into memory 10:02:00 INFO - Content-Length response header: 14498903 10:02:00 INFO - Bytes received: 14498903 10:02:00 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')]} 10:02:00 INFO - trying https://queue.taskcluster.net/v1/task/VQi_Zdf1Sr2fiUb0MKC7jg/artifacts/public/build/target.tar.bz2 10:02:00 INFO - Downloading https://queue.taskcluster.net/v1/task/VQi_Zdf1Sr2fiUb0MKC7jg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:02:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VQi_Zdf1Sr2fiUb0MKC7jg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:02:01 INFO - Downloaded 61936948 bytes. 10:02:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VQi_Zdf1Sr2fiUb0MKC7jg/artifacts/public/build/target.tar.bz2 10:02:01 INFO - mkdir: /builds/slave/test/properties 10:02:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:02:01 INFO - Writing to file /builds/slave/test/properties/build_url 10:02:01 INFO - Contents: 10:02:01 INFO - build_url:https://queue.taskcluster.net/v1/task/VQi_Zdf1Sr2fiUb0MKC7jg/artifacts/public/build/target.tar.bz2 10:02:01 INFO - Running post-action listener: _resource_record_post_action 10:02:01 INFO - Running post-action listener: set_extra_try_arguments 10:02:01 INFO - [mozharness: 2017-07-19 17:02:01.643330Z] Finished download-and-extract step (success) 10:02:01 INFO - [mozharness: 2017-07-19 17:02:01.643427Z] Running populate-webroot step. 10:02:01 INFO - Running pre-action listener: _resource_record_pre_action 10:02:01 INFO - Running main action method: populate_webroot 10:02:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:02:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:02:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:02:01 INFO - '--tppagecycles', 10:02:01 INFO - '7'], 10:02:01 INFO - 'tests': ['tsvgm']}}, 10:02:01 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:02:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:02:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:02:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:02:01 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:02:01 INFO - 'talos_options': ['--disable-e10s'], 10:02:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:02:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:02:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:02:01 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:02:01 INFO - 'talos_options': ['--disable-e10s'], 10:02:01 INFO - 'tests': ['damp', 'tps']}, 10:02:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:02:01 INFO - 'tests': ['damp', 'tps']}, 10:02:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:02:01 INFO - 'tests': ['dromaeo_dom']}, 10:02:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:02:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:02:01 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 10:02:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:02:01 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:02:01 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:02:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:02:01 INFO - 'tests': ['a11yr', 10:02:01 INFO - 'ts_paint', 10:02:01 INFO - 'tpaint', 10:02:01 INFO - 'sessionrestore', 10:02:01 INFO - 'sessionrestore_no_auto_restore', 10:02:01 INFO - 'tabpaint']}, 10:02:01 INFO - 'other-e10s': {'tests': ['a11yr', 10:02:01 INFO - 'ts_paint', 10:02:01 INFO - 'tpaint', 10:02:01 INFO - 'sessionrestore', 10:02:01 INFO - 'sessionrestore_many_windows', 10:02:01 INFO - 'sessionrestore_no_auto_restore', 10:02:01 INFO - 'tabpaint']}, 10:02:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:02:01 INFO - 'ts_paint', 10:02:01 INFO - 'tpaint', 10:02:01 INFO - 'sessionrestore', 10:02:01 INFO - 'sessionrestore_many_windows', 10:02:01 INFO - 'sessionrestore_no_auto_restore', 10:02:01 INFO - 'tabpaint']}, 10:02:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:02:01 INFO - 'ts_paint', 10:02:01 INFO - 'tpaint', 10:02:01 INFO - 'sessionrestore', 10:02:01 INFO - 'sessionrestore_many_windows', 10:02:01 INFO - 'sessionrestore_no_auto_restore', 10:02:01 INFO - 'tabpaint']}, 10:02:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:02:01 INFO - 'tests': ['a11yr', 10:02:01 INFO - 'ts_paint', 10:02:01 INFO - 'tpaint', 10:02:01 INFO - 'sessionrestore', 10:02:01 INFO - 'sessionrestore_no_auto_restore', 10:02:01 INFO - 'tabpaint']}, 10:02:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:02:01 INFO - 'tests': ['a11yr', 10:02:01 INFO - 'ts_paint', 10:02:01 INFO - 'tpaint', 10:02:01 INFO - 'sessionrestore', 10:02:01 INFO - 'sessionrestore_no_auto_restore', 10:02:01 INFO - 'tabpaint']}, 10:02:01 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 10:02:01 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 10:02:01 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 10:02:01 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:02:01 INFO - 'talos_options': ['--mitmproxy', 10:02:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:02:01 INFO - '--firstNonBlankPaint'], 10:02:01 INFO - 'tests': ['quantum_pageload_google', 10:02:01 INFO - 'quantum_pageload_youtube', 10:02:01 INFO - 'quantum_pageload_amazon', 10:02:01 INFO - 'quantum_pageload_facebook']}, 10:02:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:02:01 INFO - 'tests': ['tsvgx', 10:02:01 INFO - 'tsvgr_opacity', 10:02:01 INFO - 'tart', 10:02:01 INFO - 'tscrollx', 10:02:01 INFO - 'cart', 10:02:01 INFO - 'tsvg_static']}, 10:02:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:02:01 INFO - 'tsvgr_opacity', 10:02:01 INFO - 'tart', 10:02:01 INFO - 'tscrollx', 10:02:01 INFO - 'cart', 10:02:01 INFO - 'tsvg_static']}, 10:02:01 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:02:01 INFO - 'talos_options': ['--disable-e10s'], 10:02:01 INFO - 'tests': ['tp5o']}, 10:02:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:02:01 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:02:01 INFO - 'talos_options': ['--disable-e10s', 10:02:01 INFO - '--xperf_path', 10:02:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:02:01 INFO - 'tests': ['tp5n']}, 10:02:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:02:01 INFO - 'talos_options': ['--xperf_path', 10:02:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:02:01 INFO - 'tests': ['tp5n']}}, 10:02:01 INFO - 'talos.zip': {'path': '', 10:02:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:02:01 INFO - Running post-action listener: _resource_record_post_action 10:02:01 INFO - [mozharness: 2017-07-19 17:02:01.658702Z] Finished populate-webroot step (success) 10:02:01 INFO - [mozharness: 2017-07-19 17:02:01.658793Z] Running create-virtualenv step. 10:02:01 INFO - Running pre-action listener: _resource_record_pre_action 10:02:01 INFO - Running main action method: create_virtualenv 10:02:01 INFO - Creating virtualenv /builds/slave/test/build/venv 10:02:01 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 10:02:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:02:01 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 10:02:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:02:01 INFO - Using real prefix '/usr' 10:02:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:02:02 INFO - Installing distribute.............................................................................................................................................................................................done. 10:02:04 INFO - Installing pip.................done. 10:02:04 INFO - Return code: 0 10:02:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:02:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:02:04 INFO - Reading from file tmpfile_stdout 10:02:04 INFO - Output received: 10:02:04 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) 10:02:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:02: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')]} 10:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02: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')]} 10:02:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:04 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 0xca81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016d10>, '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 0x1017c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10180c0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1500483085.397713-196695689', '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 10:02:04 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 10:02:04 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 10:02:04 INFO - Using env: {'DISPLAY': ':0', 10:02:04 INFO - 'HOME': '/home/cltbld', 10:02:04 INFO - 'LANG': 'en_US.UTF-8', 10:02:04 INFO - 'LANGUAGE': 'en_US:en', 10:02:04 INFO - 'LOGNAME': 'cltbld', 10:02:04 INFO - 'MAIL': '/var/mail/cltbld', 10:02:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:04 INFO - 'MOZ_NO_REMOTE': '1', 10:02:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:04 INFO - 'NO_EM_RESTART': '1', 10:02:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:04 INFO - 'PWD': '/builds/slave/test', 10:02:04 INFO - 'SHELL': '/bin/bash', 10:02:04 INFO - 'SHLVL': '1', 10:02:04 INFO - 'TERM': 'linux', 10:02:04 INFO - 'TMOUT': '86400', 10:02:04 INFO - 'USER': 'cltbld', 10:02:04 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1500483085.397713-196695689', 10:02:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:04 INFO - '_': '/tools/buildbot/bin/python'} 10:02:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:04 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 10:02:04 INFO - Cleaning up... 10:02:04 INFO - Return code: 0 10:02:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:02: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')]} 10:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02: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')]} 10:02:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:04 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 0xca81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016d10>, '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 0x1017c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10180c0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1500483085.397713-196695689', '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 10:02:04 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 10:02:04 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 10:02:04 INFO - Using env: {'DISPLAY': ':0', 10:02:04 INFO - 'HOME': '/home/cltbld', 10:02:04 INFO - 'LANG': 'en_US.UTF-8', 10:02:04 INFO - 'LANGUAGE': 'en_US:en', 10:02:04 INFO - 'LOGNAME': 'cltbld', 10:02:04 INFO - 'MAIL': '/var/mail/cltbld', 10:02:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:04 INFO - 'MOZ_NO_REMOTE': '1', 10:02:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:04 INFO - 'NO_EM_RESTART': '1', 10:02:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:04 INFO - 'PWD': '/builds/slave/test', 10:02:04 INFO - 'SHELL': '/bin/bash', 10:02:04 INFO - 'SHLVL': '1', 10:02:04 INFO - 'TERM': 'linux', 10:02:04 INFO - 'TMOUT': '86400', 10:02:04 INFO - 'USER': 'cltbld', 10:02:04 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1500483085.397713-196695689', 10:02:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:04 INFO - '_': '/tools/buildbot/bin/python'} 10:02:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:04 INFO - Downloading/unpacking psutil>=3.1.1 10:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:02:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:02:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:02:06 INFO - Installing collected packages: psutil 10:02:06 INFO - Running setup.py install for psutil 10:02:06 INFO - building 'psutil._psutil_linux' extension 10:02:06 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 10:02:06 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 10:02:06 INFO - building 'psutil._psutil_posix' extension 10:02:06 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 10:02:06 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 10:02:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:02:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:02:06 INFO - Successfully installed psutil 10:02:06 INFO - Cleaning up... 10:02:06 INFO - Return code: 0 10:02:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:02:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xca81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016d10>, '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 0x1017c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10180c0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1500483085.397713-196695689', '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 10:02:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:02:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:02:06 INFO - Using env: {'DISPLAY': ':0', 10:02:06 INFO - 'HOME': '/home/cltbld', 10:02:06 INFO - 'LANG': 'en_US.UTF-8', 10:02:06 INFO - 'LANGUAGE': 'en_US:en', 10:02:06 INFO - 'LOGNAME': 'cltbld', 10:02:06 INFO - 'MAIL': '/var/mail/cltbld', 10:02:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:06 INFO - 'MOZ_NO_REMOTE': '1', 10:02:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:06 INFO - 'NO_EM_RESTART': '1', 10:02:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:06 INFO - 'PWD': '/builds/slave/test', 10:02:06 INFO - 'SHELL': '/bin/bash', 10:02:06 INFO - 'SHLVL': '1', 10:02:06 INFO - 'TERM': 'linux', 10:02:06 INFO - 'TMOUT': '86400', 10:02:06 INFO - 'USER': 'cltbld', 10:02:06 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1500483085.397713-196695689', 10:02:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:06 INFO - '_': '/tools/buildbot/bin/python'} 10:02:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:02:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:02:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:02:07 INFO - Installing collected packages: mozsystemmonitor 10:02:07 INFO - Running setup.py install for mozsystemmonitor 10:02:08 INFO - Successfully installed mozsystemmonitor 10:02:08 INFO - Cleaning up... 10:02:08 INFO - Return code: 0 10:02:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:02: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')]} 10:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02: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')]} 10:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02: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', '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 0xca81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016d10>, '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 0x1017c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10180c0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1500483085.397713-196695689', '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 10:02: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:02: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 jsonschema==2.5.1 10:02:08 INFO - Using env: {'DISPLAY': ':0', 10:02:08 INFO - 'HOME': '/home/cltbld', 10:02:08 INFO - 'LANG': 'en_US.UTF-8', 10:02:08 INFO - 'LANGUAGE': 'en_US:en', 10:02:08 INFO - 'LOGNAME': 'cltbld', 10:02:08 INFO - 'MAIL': '/var/mail/cltbld', 10:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:08 INFO - 'MOZ_NO_REMOTE': '1', 10:02:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:08 INFO - 'NO_EM_RESTART': '1', 10:02:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:08 INFO - 'PWD': '/builds/slave/test', 10:02:08 INFO - 'SHELL': '/bin/bash', 10:02:08 INFO - 'SHLVL': '1', 10:02:08 INFO - 'TERM': 'linux', 10:02:08 INFO - 'TMOUT': '86400', 10:02:08 INFO - 'USER': 'cltbld', 10:02:08 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1500483085.397713-196695689', 10:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:08 INFO - '_': '/tools/buildbot/bin/python'} 10:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:08 INFO - Downloading/unpacking jsonschema==2.5.1 10:02: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 10:02: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 10:02: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 10:02: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 10:02:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:02:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:09 INFO - Downloading functools32-3.2.3-2.tar.gz 10:02:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:02:09 INFO - warning: no files found matching '*.txt' 10:02:09 INFO - no previously-included directories found matching 'build' 10:02:09 INFO - no previously-included directories found matching 'dist' 10:02:09 INFO - no previously-included directories found matching '.git*' 10:02:09 INFO - Installing collected packages: jsonschema, functools32 10:02:09 INFO - Running setup.py install for functools32 10:02:09 INFO - warning: no files found matching '*.txt' 10:02:09 INFO - no previously-included directories found matching 'build' 10:02:09 INFO - no previously-included directories found matching 'dist' 10:02:09 INFO - no previously-included directories found matching '.git*' 10:02:09 INFO - Successfully installed jsonschema functools32 10:02:09 INFO - Cleaning up... 10:02:09 INFO - Return code: 0 10:02:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:02:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xca81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016d10>, '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 0x1017c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10180c0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1500483085.397713-196695689', '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 10:02:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:02:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:02:09 INFO - Using env: {'DISPLAY': ':0', 10:02:09 INFO - 'HOME': '/home/cltbld', 10:02:09 INFO - 'LANG': 'en_US.UTF-8', 10:02:09 INFO - 'LANGUAGE': 'en_US:en', 10:02:09 INFO - 'LOGNAME': 'cltbld', 10:02:09 INFO - 'MAIL': '/var/mail/cltbld', 10:02:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:09 INFO - 'MOZ_NO_REMOTE': '1', 10:02:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:09 INFO - 'NO_EM_RESTART': '1', 10:02:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:09 INFO - 'PWD': '/builds/slave/test', 10:02:09 INFO - 'SHELL': '/bin/bash', 10:02:09 INFO - 'SHLVL': '1', 10:02:09 INFO - 'TERM': 'linux', 10:02:09 INFO - 'TMOUT': '86400', 10:02:09 INFO - 'USER': 'cltbld', 10:02:09 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1500483085.397713-196695689', 10:02:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:09 INFO - '_': '/tools/buildbot/bin/python'} 10:02:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:02:09 INFO - Cleaning up... 10:02:09 INFO - Return code: 0 10:02:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:02:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xca81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016d10>, '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 0x1017c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10180c0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1500483085.397713-196695689', '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 10:02:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:02:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:02:09 INFO - Using env: {'DISPLAY': ':0', 10:02:09 INFO - 'HOME': '/home/cltbld', 10:02:09 INFO - 'LANG': 'en_US.UTF-8', 10:02:09 INFO - 'LANGUAGE': 'en_US:en', 10:02:09 INFO - 'LOGNAME': 'cltbld', 10:02:09 INFO - 'MAIL': '/var/mail/cltbld', 10:02:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:09 INFO - 'MOZ_NO_REMOTE': '1', 10:02:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:09 INFO - 'NO_EM_RESTART': '1', 10:02:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:09 INFO - 'PWD': '/builds/slave/test', 10:02:09 INFO - 'SHELL': '/bin/bash', 10:02:09 INFO - 'SHLVL': '1', 10:02:09 INFO - 'TERM': 'linux', 10:02:09 INFO - 'TMOUT': '86400', 10:02:09 INFO - 'USER': 'cltbld', 10:02:09 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1500483085.397713-196695689', 10:02:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:09 INFO - '_': '/tools/buildbot/bin/python'} 10:02:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:10 INFO - Downloading/unpacking blobuploader==1.2.4 10:02: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 10:02: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 10:02: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 10:02: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 10:02:11 INFO - Downloading blobuploader-1.2.4.tar.gz 10:02:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:02:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:02: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 10:02: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 10:02: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 10:02: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 10:02:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:02:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:02: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 10:02: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 10:02: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 10:02: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 10:02:11 INFO - Downloading docopt-0.6.1.tar.gz 10:02:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:02:11 INFO - Installing collected packages: blobuploader, requests, docopt 10:02:11 INFO - Running setup.py install for blobuploader 10:02:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:02:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:02:11 INFO - Running setup.py install for requests 10:02:12 INFO - Running setup.py install for docopt 10:02:12 INFO - Successfully installed blobuploader requests docopt 10:02:12 INFO - Cleaning up... 10:02:12 INFO - Return code: 0 10:02:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:12 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 0xca81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016d10>, '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 0x1017c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10180c0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1500483085.397713-196695689', '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 10:02:12 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 10:02:12 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 10:02:12 INFO - Using env: {'DISPLAY': ':0', 10:02:12 INFO - 'HOME': '/home/cltbld', 10:02:12 INFO - 'LANG': 'en_US.UTF-8', 10:02:12 INFO - 'LANGUAGE': 'en_US:en', 10:02:12 INFO - 'LOGNAME': 'cltbld', 10:02:12 INFO - 'MAIL': '/var/mail/cltbld', 10:02:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:12 INFO - 'MOZ_NO_REMOTE': '1', 10:02:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:12 INFO - 'NO_EM_RESTART': '1', 10:02:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:12 INFO - 'PWD': '/builds/slave/test', 10:02:12 INFO - 'SHELL': '/bin/bash', 10:02:12 INFO - 'SHLVL': '1', 10:02:12 INFO - 'TERM': 'linux', 10:02:12 INFO - 'TMOUT': '86400', 10:02:12 INFO - 'USER': 'cltbld', 10:02:12 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1500483085.397713-196695689', 10:02:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:12 INFO - '_': '/tools/buildbot/bin/python'} 10:02:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:02:12 INFO - Running setup.py (path:/tmp/pip-0OfKCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:02:12 INFO - Running setup.py (path:/tmp/pip-MJ6tkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:02:12 INFO - Running setup.py (path:/tmp/pip-z2gUvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:02:12 INFO - Running setup.py (path:/tmp/pip-7SmIfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:02:12 INFO - Running setup.py (path:/tmp/pip-V9NV5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:02:13 INFO - Running setup.py (path:/tmp/pip-QW7RPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:02:13 INFO - Running setup.py (path:/tmp/pip-IFAuZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:02:13 INFO - Running setup.py (path:/tmp/pip-qvyrDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:02:13 INFO - Running setup.py (path:/tmp/pip-ZZi4ot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:02:13 INFO - Running setup.py (path:/tmp/pip-OwC1sk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:02:13 INFO - Running setup.py (path:/tmp/pip-PMcQmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:02:13 INFO - Running setup.py (path:/tmp/pip-ZiaZY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:02:13 INFO - Running setup.py (path:/tmp/pip-5RO0kl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:02:13 INFO - Running setup.py (path:/tmp/pip-6Vj0hQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:13 INFO - Running setup.py (path:/tmp/pip-1CEjCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:02:13 INFO - Running setup.py (path:/tmp/pip-309vzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:02:13 INFO - Running setup.py (path:/tmp/pip-o_c9ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:02:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:02:13 INFO - Running setup.py install for manifestparser 10:02:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:02:13 INFO - Running setup.py install for mozcrash 10:02:14 INFO - Running setup.py install for mozdebug 10:02:14 INFO - Running setup.py install for mozdevice 10:02:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:02:14 INFO - Running setup.py install for mozfile 10:02:14 INFO - Running setup.py install for mozhttpd 10:02:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:02:14 INFO - Running setup.py install for mozinfo 10:02:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:02:14 INFO - Running setup.py install for mozInstall 10:02:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:02:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:02:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:02:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:02:14 INFO - Running setup.py install for mozleak 10:02:14 INFO - Running setup.py install for mozlog 10:02:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:02:14 INFO - Running setup.py install for moznetwork 10:02:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:02:15 INFO - Running setup.py install for mozprocess 10:02:15 INFO - Running setup.py install for mozprofile 10:02:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:02:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:02:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:02:15 INFO - Running setup.py install for mozrunner 10:02:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:02:15 INFO - Running setup.py install for mozscreenshot 10:02:15 INFO - Running setup.py install for moztest 10:02:15 INFO - Running setup.py install for mozversion 10:02:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:02:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:02:15 INFO - Cleaning up... 10:02:15 INFO - Return code: 0 10:02:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:02:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:15 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 0xca81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016d10>, '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 0x1017c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10180c0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1500483085.397713-196695689', '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 10:02:15 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 10:02:15 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 10:02:15 INFO - Using env: {'DISPLAY': ':0', 10:02:15 INFO - 'HOME': '/home/cltbld', 10:02:15 INFO - 'LANG': 'en_US.UTF-8', 10:02:15 INFO - 'LANGUAGE': 'en_US:en', 10:02:15 INFO - 'LOGNAME': 'cltbld', 10:02:15 INFO - 'MAIL': '/var/mail/cltbld', 10:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:15 INFO - 'MOZ_NO_REMOTE': '1', 10:02:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:15 INFO - 'NO_EM_RESTART': '1', 10:02:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:15 INFO - 'PWD': '/builds/slave/test', 10:02:15 INFO - 'SHELL': '/bin/bash', 10:02:15 INFO - 'SHLVL': '1', 10:02:15 INFO - 'TERM': 'linux', 10:02:15 INFO - 'TMOUT': '86400', 10:02:15 INFO - 'USER': 'cltbld', 10:02:15 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1500483085.397713-196695689', 10:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:15 INFO - '_': '/tools/buildbot/bin/python'} 10:02:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:02:15 INFO - Running setup.py (path:/tmp/pip-jrQHl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:02:15 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)) 10:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:02:15 INFO - Running setup.py (path:/tmp/pip-Zt1uc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:02:16 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)) 10:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:02:16 INFO - Running setup.py (path:/tmp/pip-iubOtj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:02:16 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)) 10:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:02:16 INFO - Running setup.py (path:/tmp/pip-Eg2SnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:02:16 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)) 10:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:02:16 INFO - Running setup.py (path:/tmp/pip-dQnVy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:02:16 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)) 10:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:02:16 INFO - Running setup.py (path:/tmp/pip-KU9Z3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:02:16 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)) 10:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:02:16 INFO - Running setup.py (path:/tmp/pip-N_Ephg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:02:16 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)) 10:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:02:16 INFO - Running setup.py (path:/tmp/pip-RkwekC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:02:16 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)) 10:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:02:16 INFO - Running setup.py (path:/tmp/pip-7zWkMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:02:16 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)) 10:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:02:16 INFO - Running setup.py (path:/tmp/pip-iErTys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:02:16 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)) 10:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:02:16 INFO - Running setup.py (path:/tmp/pip-WNPrlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:02:16 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)) 10:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:02:16 INFO - Running setup.py (path:/tmp/pip-zYcYFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:02:16 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)) 10:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:02:16 INFO - Running setup.py (path:/tmp/pip-6VwxrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:02:16 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)) 10:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:02:16 INFO - Running setup.py (path:/tmp/pip-sPDuW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:02:16 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)) 10:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:16 INFO - Running setup.py (path:/tmp/pip-O6HpCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:16 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)) 10:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:02:16 INFO - Running setup.py (path:/tmp/pip-frvqCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:02:17 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)) 10:02:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:02:17 INFO - Running setup.py (path:/tmp/pip-Zptrb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:02:17 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)) 10:02:17 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)) 10:02:17 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)) 10:02:17 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)) 10:02:17 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)) 10:02:17 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)) 10:02:17 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)) 10:02:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:02:17 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 10:02:17 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 10:02:17 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 10:02:17 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 10:02:18 INFO - Downloading blessings-1.6.tar.gz 10:02:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:02:18 INFO - Installing collected packages: blessings 10:02:18 INFO - Running setup.py install for blessings 10:02:18 INFO - Successfully installed blessings 10:02:18 INFO - Cleaning up... 10:02:18 INFO - Return code: 0 10:02:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:02:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:02:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:02:18 INFO - Reading from file tmpfile_stdout 10:02:18 INFO - Current package versions: 10:02:18 INFO - argparse == 1.2.1 10:02:18 INFO - blessings == 1.6 10:02:18 INFO - blobuploader == 1.2.4 10:02:18 INFO - docopt == 0.6.1 10:02:18 INFO - functools32 == 3.2.3-2 10:02:18 INFO - jsonschema == 2.5.1 10:02:18 INFO - manifestparser == 1.1 10:02:18 INFO - mozInstall == 1.13 10:02:18 INFO - mozcrash == 1.0 10:02:18 INFO - mozdebug == 0.1 10:02:18 INFO - mozdevice == 0.51 10:02:18 INFO - mozfile == 1.2 10:02:18 INFO - mozhttpd == 0.7 10:02:18 INFO - mozinfo == 0.10 10:02:18 INFO - mozleak == 0.1 10:02:18 INFO - mozlog == 3.5 10:02:18 INFO - moznetwork == 0.27 10:02:18 INFO - mozprocess == 0.25 10:02:18 INFO - mozprofile == 0.28 10:02:18 INFO - mozrunner == 6.13 10:02:18 INFO - mozscreenshot == 0.1 10:02:18 INFO - mozsystemmonitor == 0.3 10:02:18 INFO - moztest == 0.8 10:02:18 INFO - mozversion == 1.4 10:02:18 INFO - psutil == 3.1.1 10:02:18 INFO - requests == 1.2.3 10:02:18 INFO - wsgiref == 0.1.2 10:02:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:02:18 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')]} 10:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:18 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')]} 10:02:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:18 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 0xca81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016d10>, '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 0x1017c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10180c0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1500483085.397713-196695689', '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 10:02:18 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 10:02:18 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 10:02:18 INFO - Using env: {'DISPLAY': ':0', 10:02:18 INFO - 'HOME': '/home/cltbld', 10:02:18 INFO - 'LANG': 'en_US.UTF-8', 10:02:18 INFO - 'LANGUAGE': 'en_US:en', 10:02:18 INFO - 'LOGNAME': 'cltbld', 10:02:18 INFO - 'MAIL': '/var/mail/cltbld', 10:02:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:18 INFO - 'MOZ_NO_REMOTE': '1', 10:02:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:18 INFO - 'NO_EM_RESTART': '1', 10:02:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:18 INFO - 'PWD': '/builds/slave/test', 10:02:18 INFO - 'SHELL': '/bin/bash', 10:02:18 INFO - 'SHLVL': '1', 10:02:18 INFO - 'TERM': 'linux', 10:02:18 INFO - 'TMOUT': '86400', 10:02:18 INFO - 'USER': 'cltbld', 10:02:18 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1500483085.397713-196695689', 10:02:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:18 INFO - '_': '/tools/buildbot/bin/python'} 10:02:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:18 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)) 10:02:18 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)) 10:02:18 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)) 10:02:18 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)) 10:02:18 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)) 10:02:18 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)) 10:02:18 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)) 10:02:18 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)) 10:02:18 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)) 10:02:18 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:02:18 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 10:02:18 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 10:02:18 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 10:02:18 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 10:02:19 INFO - Downloading marionette_driver-1.4.0.tar.gz 10:02:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 10:02:20 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 10:02: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 10:02: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 10:02: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 10:02: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 10:02:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 10:02:20 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)) 10:02:20 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)) 10:02:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:02:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:02:20 INFO - Installing collected packages: marionette-driver, simplejson 10:02:20 INFO - Running setup.py install for marionette-driver 10:02:20 INFO - Running setup.py install for simplejson 10:02:20 INFO - building 'simplejson._speedups' extension 10:02:20 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 10:02:21 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 10:02:21 INFO - Successfully installed marionette-driver simplejson 10:02:21 INFO - Cleaning up... 10:02:21 INFO - Return code: 0 10:02:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:02:21 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')]} 10:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:21 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')]} 10:02:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:21 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 0xca81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016d10>, '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 0x1017c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10180c0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1500483085.397713-196695689', '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 10:02:21 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 10:02:21 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 10:02:21 INFO - Using env: {'DISPLAY': ':0', 10:02:21 INFO - 'HOME': '/home/cltbld', 10:02:21 INFO - 'LANG': 'en_US.UTF-8', 10:02:21 INFO - 'LANGUAGE': 'en_US:en', 10:02:21 INFO - 'LOGNAME': 'cltbld', 10:02:21 INFO - 'MAIL': '/var/mail/cltbld', 10:02:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:21 INFO - 'MOZ_NO_REMOTE': '1', 10:02:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:21 INFO - 'NO_EM_RESTART': '1', 10:02:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:21 INFO - 'PWD': '/builds/slave/test', 10:02:21 INFO - 'SHELL': '/bin/bash', 10:02:21 INFO - 'SHLVL': '1', 10:02:21 INFO - 'TERM': 'linux', 10:02:21 INFO - 'TMOUT': '86400', 10:02:21 INFO - 'USER': 'cltbld', 10:02:21 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1500483085.397713-196695689', 10:02:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:21 INFO - '_': '/tools/buildbot/bin/python'} 10:02:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:02:21 INFO - Cleaning up... 10:02:21 INFO - Return code: 0 10:02:21 INFO - Running post-action listener: _resource_record_post_action 10:02:21 INFO - Running post-action listener: _start_resource_monitoring 10:02:21 INFO - Starting resource monitoring. 10:02:21 INFO - [mozharness: 2017-07-19 17:02:21.679201Z] Finished create-virtualenv step (success) 10:02:21 INFO - [mozharness: 2017-07-19 17:02:21.679719Z] Running install step. 10:02:21 INFO - Running pre-action listener: _resource_record_pre_action 10:02:21 INFO - Running main action method: install 10:02:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:02:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:02:21 INFO - Reading from file tmpfile_stdout 10:02:21 INFO - Detecting whether we're running mozinstall >=1.0... 10:02:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:02:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:02:22 INFO - Reading from file tmpfile_stdout 10:02:22 INFO - Output received: 10:02:22 INFO - Usage: mozinstall [options] installer 10:02:22 INFO - Options: 10:02:22 INFO - -h, --help show this help message and exit 10:02:22 INFO - -d DEST, --destination=DEST 10:02:22 INFO - Directory to install application into. [default: 10:02:22 INFO - "/builds/slave/test"] 10:02:22 INFO - --app=APP Application being installed. [default: firefox] 10:02:22 INFO - mkdir: /builds/slave/test/build/application 10:02:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:02:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:02:40 INFO - Reading from file tmpfile_stdout 10:02:40 INFO - Output received: 10:02:40 INFO - /builds/slave/test/build/application/firefox/firefox 10:02:40 INFO - Running post-action listener: _resource_record_post_action 10:02:40 INFO - [mozharness: 2017-07-19 17:02:40.014624Z] Finished install step (success) 10:02:40 INFO - [mozharness: 2017-07-19 17:02:40.014876Z] Running setup-mitmproxy step. 10:02:40 INFO - Running pre-action listener: _resource_record_pre_action 10:02:40 INFO - Running main action method: setup_mitmproxy 10:02:40 INFO - Skipping: mitmproxy is not required 10:02:40 INFO - Running post-action listener: _resource_record_post_action 10:02:40 INFO - [mozharness: 2017-07-19 17:02:40.016002Z] Finished setup-mitmproxy step (success) 10:02:40 INFO - [mozharness: 2017-07-19 17:02:40.016237Z] Running run-tests step. 10:02:40 INFO - Running pre-action listener: _resource_record_pre_action 10:02:40 INFO - Running pre-action listener: _set_gcov_prefix 10:02:40 INFO - Running main action method: run_tests 10:02:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:02:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:02:40 INFO - Python 2.7.3 10:02:40 INFO - Return code: 0 10:02:40 INFO - grabbing minidump binary from tooltool 10:02:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:40 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016d10>, '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 0x1017c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10180c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:02:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:02:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:02:40 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:02:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:02:40 INFO - Return code: 0 10:02:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:02:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:02:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:02:40 INFO - ENV: RUST_BACKTRACE is now 1 10:02:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:02:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:02:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VQi_Zdf1Sr2fiUb0MKC7jg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 10:02:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VQi_Zdf1Sr2fiUb0MKC7jg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 10:02:40 INFO - Using env: {'DISPLAY': ':0', 10:02:40 INFO - 'HOME': '/home/cltbld', 10:02:40 INFO - 'LANG': 'en_US.UTF-8', 10:02:40 INFO - 'LANGUAGE': 'en_US:en', 10:02:40 INFO - 'LOGNAME': 'cltbld', 10:02:40 INFO - 'MAIL': '/var/mail/cltbld', 10:02:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:02:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:02:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:40 INFO - 'MOZ_NO_REMOTE': '1', 10:02:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:02:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:40 INFO - 'NO_EM_RESTART': '1', 10:02:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:40 INFO - 'PWD': '/builds/slave/test', 10:02:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:02:40 INFO - 'RUST_BACKTRACE': '1', 10:02:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:02:40 INFO - 'SHELL': '/bin/bash', 10:02:40 INFO - 'SHLVL': '1', 10:02:40 INFO - 'TERM': 'linux', 10:02:40 INFO - 'TMOUT': '86400', 10:02:40 INFO - 'USER': 'cltbld', 10:02:40 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1500483085.397713-196695689', 10:02:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:40 INFO - '_': '/tools/buildbot/bin/python'} 10:02:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VQi_Zdf1Sr2fiUb0MKC7jg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 10:02:40 INFO - mozversion application_buildid: 20170719162250 10:02:40 INFO - mozversion application_changeset: 4b32e7ce740eaf6434180bc9e44731dab0aa67cc 10:02:40 INFO - mozversion application_display_name: Nightly 10:02:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:02:40 INFO - mozversion application_name: Firefox 10:02:40 INFO - mozversion application_remotingname: firefox 10:02:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:02:40 INFO - mozversion application_vendor: Mozilla 10:02:40 INFO - mozversion application_version: 56.0a1 10:02:40 INFO - mozversion platform_buildid: 20170719162250 10:02:40 INFO - mozversion platform_changeset: 4b32e7ce740eaf6434180bc9e44731dab0aa67cc 10:02:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:02:40 INFO - mozversion platform_version: 56.0a1 10:02:40 INFO - using testdate: 1500483760 10:02:40 INFO - actual date: 1500483760 10:02:40 INFO - starting webserver on 'localhost:50260' 10:02:40 INFO - SUITE-START | Running 2 tests 10:02:40 INFO - TEST-START | dromaeo_css 10:02:40 INFO - Initialising browser for dromaeo_css test... 10:02:40 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50260/getInfo.html -profile /tmp/tmpaah_SA/profile 10:02:40 INFO - TEST-INFO | started process 28246 (/builds/slave/test/build/application/firefox/firefox http://localhost:50260/getInfo.html) 10:02:46 INFO - TEST-INFO | 28246: exit 0 10:02:46 INFO - Browser initialized. 10:02:46 INFO - Running cycle 1/1 for dromaeo_css test... 10:02:46 INFO - TEST-INFO | started process 28460 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaah_SA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:02:58 INFO - PID 28460 | RSS: Main: 176361472 10:02:58 INFO - PID 28460 | 10:05:57 INFO - PID 28460 | Cycle 1(1): loaded http://localhost:50260/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50260/tests/dromaeo/cssquery-ext.html) 10:05:58 INFO - PID 28460 | RSS: Main: 178827264 10:05:58 INFO - PID 28460 | 10:09:00 INFO - PID 28460 | Cycle 1(1): loaded http://localhost:50260/tests/dromaeo/cssquery-ext.html (next: http://localhost:50260/tests/dromaeo/cssquery-jquery.html) 10:09:01 INFO - PID 28460 | RSS: Main: 176664576 10:09:01 INFO - PID 28460 | 10:12:02 INFO - PID 28460 | Cycle 1(1): loaded http://localhost:50260/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50260/tests/dromaeo/cssquery-mootools.html) 10:12:03 INFO - PID 28460 | RSS: Main: 178126848 10:12:03 INFO - PID 28460 | 10:15:05 INFO - PID 28460 | Cycle 1(1): loaded http://localhost:50260/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50260/tests/dromaeo/cssquery-prototype.html) 10:15:05 INFO - PID 28460 | RSS: Main: 177115136 10:15:05 INFO - PID 28460 | 10:18:09 INFO - PID 28460 | Cycle 1(1): loaded http://localhost:50260/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50260/tests/dromaeo/cssquery-yui.html) 10:18:10 INFO - PID 28460 | RSS: Main: 178589696 10:18:10 INFO - PID 28460 | 10:21:12 INFO - PID 28460 | Cycle 1(1): loaded http://localhost:50260/tests/dromaeo/cssquery-yui.html (next: http://localhost:50260/tests/dromaeo/cssquery-dojo.html) 10:21:12 INFO - PID 28460 | RSS: Main: 180420608 10:21:12 INFO - PID 28460 | 10:21:12 INFO - PID 28460 | __start_tp_report 10:21:12 INFO - PID 28460 | _x_x_mozilla_page_load 10:21:12 INFO - PID 28460 | _x_x_mozilla_page_load_details 10:21:12 INFO - PID 28460 | |i|pagename|runs| 10:21:12 INFO - PID 28460 | |0;dojo.html;3041.9999999999986;3104.549840273159;3105.1616063662814;3109.626844778626;3139.0896639974408;6020.789272375468;6090.695465226738;6132.570720049598;6150.81547553573;6185.597936134153;6099.939000609993;6124.387561243873;6129.754809807602;6140.907886381697;6146.938530614692;5510.862228444281;5585.413531579186;5594.888102237953;5612.35457922338;5684;5654.208410822488;5658.8019419320335;5672.489475947164;5713.942860571383;5716.228309178249;5409.540189083893;5521.641093328961;5588.189712491686;5615.045442274803;5622.746976386073;5524.696141712204;5584.944150558483;5612.550995920316;5621.550275977953;5626.043572592669;5462.289902312714;5489.835304940858;5552.750126244328;5554.0835762099205;5564.610477266593;5860.238169038041;5979.133025711291;6013.1581578579035;6026.638401695912;6027.578069535134;6467.644279564622;6498.740050397979;6548.738050477975;6555.180602424697;6575.539712220147;6547.116139321179;6557.5081868860025;6626.966865165691;6639.3692599203;6657.900131498031;6021.909671354933;6072.119542666333;6117.632942023404;6169.167162433104;6200.255969283715;6777.49168812341;6852.45180385568;6864.279250678706;6866.244713081557;6867.3476019778045;6468.06213099098;6484.513661475314;6543.509236807258;6545.509086818508;6551.6069035858;6357.014662727284;6508.284088750233;6523.249826269945;6528.281888992207;6621.768238111643;6494.577852439576;6574.638394888231;6577.638229897306;6618.7021584028835;6622.602643841385;6516.348365163446;6529.444997175198;6620.668966551653;6625.668716564152;6631.966840165865;5239.345081864767;5341.946580534222;5347.839564813062;5349.117395629678;5399.217113518518;4502.887427814266;4542.795574199169;4573.314002899525;4610.861674149781;4638.1883170445035;5684.34630017545;5738.942610573924;5744.51171650406;5752.539796816244;5758.452946970031;6584.374484423972;6590.538662293689;6611.074449577063;6682.766103186463;6689.297623749533;5581.4976652100695;5658.943410565924;5663.9716801415725;5738.454846789548;5762.394948530427;5862.032764593794;5905.1142328650185;5912.260967379078;5916.822495325147;5917.378675239038;6362.0774987627465;6378.649174295366;6396.9040464394;6467.773627923;6478.902816457757;6473.708683109366;6505.186851643544;6540.084388185753;6561.048647946117;6660.56706314088;6401.935980640134;6418.326075762165;6442.967785161044;6459.741610335534;6463.192100987377;6455.903161452488;6483.351664833479;6496.480281577557;6566.212054553484;6574.408303252731;6530.902036469552;6560.737570497317;6590.487894314349;6627.237867645283;6673.766418175341;6296.6851657417865;6301.338359472373;6308.968455157695;6409.070684750778;6427.228732552124;6345.96827015862;6352.428281454507;6413.2945376007665;6422.133012043314;6443.96778016107;6237.5009999200865;6301.275353334242;6381.3937675920715;6399.168108146097;6401.583897046677;6377.77677781294;6433.356664333529;6442;6516.413522782972;6555;6124.755009799558;6155.076738489262;6260.342664020212;6300.84247893788;6312.084747711464 10:21:12 INFO - PID 28460 | |1;ext.html;768.5350363030367;770.4876257288903;781.9296263336299;801.3068695578323;817.8568750468669;43479.78260108699;43616.34575481362;43760;44224.778876105614;44261.114777704424;38513;38594.228115437676;38675.22649547007;38782.41826372607;38814.8059259704;6863.7940861774105;7012.8948065778795;7015.6141412222305;7016.228214896358;7018.122734658168;6888.380045795878;6975.441964642841;6983.441324694012;6985.615791131486;6987.091678081868;6939.861202775942;7390.593517356543;7991.041075071;8008.919910800905;8017.599120044004;7919.524828510279;7972.720954766613;7973.362131029504;7977;7984;7607.125180604246;7841.21587841217;7880.763577092696;7905.446618736691;7932.286094251545;40239.597604023875;40643.1871362574;40723.796381018205;40749.388759168636;40772.184556308704;3510.543629328171;3536.5756109266795;3556.1287484566446;3561.6972557332656;3568.7680300780366;32433.675663243303;32555.51166732501;32674.6732532674;32685.50971735426;32712.182195445304;4878.926816097762;4884.242942343943;4887.682300650446;4905.166121759309;4917.950820491785;180522.0973895122;185217;185471;187172.0641396798;233003;52274.73862630662;52899;52950;52974.205386919224;53109.2033619496;54409.1838622421;54449.45550544523;54681.72659136679;55026.97351645698;55090.449095509335;16504;16518;16532.173391330387;16555;16595.253213605418;13458.057935944586;13561.728765424636;13562.660933476742;13567.932160339333;13578;14960.326785294688;15017.624559386102;15168;15174.24128793556;15290.617734556725;5964.403559644001;6009.188759517409;6072.483838873657;6101.725422356005;6156.138140660311;980.6763767956558;989.1246247071393;1002.9297949143636;1018.4754851251612;1033.9224558158169;22600.886995565244;22782.31653050411;23569.292921212393;26906.32734181661;28382.432351352858;1098.2367254757867;1118.0440723181725;1124.6850881753123;1136.1365362324693;1137.5051852444212;12315.815262771066;12592.81110783339;12598.307093109783;12645.683857903441;12681.49274029047;231086;232938;233241;233680;234134;55760.16359754607;55899.441005589426;56007.43992560104;56221.43778562244;56299.15551266734;1446.8697817196503;1486.524312220101;1497.286728912282;1506.5555661080007;1528.914470725775;22271.44321391978;22556.887215563816;22875.084996600614;22970.322722304958;23433.297001089995;38186.80906595449;38384.88883111456;38417.42373864338;38496;38625;189442;189798;190224;190828;191120;36833.81583092068;37873;38660.80669596634;39320.82037538879;39565;48813;50144;50262.497375025785;50326.245106322705;50482.74758626183;33106.50340244947;34850.30299393947;35057.298854023284;35099.82450087733;35425.1143721409;33809.3238135231;33823;34441;34653;35080.47379289364;38431;38443.615563844;38527.229455411296;38651.22697546089;39029.6097039026;33344.66655333416;33713.66286337105;33882;34299.82850085833;34641.13397165091;24032.918518666353;24047.95592374668;24699.461171478968;24921.376965576004;25048.499030018935 10:21:12 INFO - PID 28460 | |2;jquery.html;565.9151127330903;571.2431028886726;572.7852055479195;576.3717547872818;593.1636392686312;22404.55190896181;22581.54836903263;23413.297601071994;23414.64878026829;23455.41361465962;25934.48131037378;26330.73669263307;26465.603015954726;26478.86760566199;26537.336566585796;6502.447291980176;6655.633940133291;6657.800265992028;6675.8331041724105;6685.298043705414;6280.811575652738;6563.868722625544;6572.112764776742;6630.900536491957;6683.198016238058;6525.086487891699;6528.347165283458;6538.150040494753;6542.574732642387;6565.507586930976;6464.191976003;6483.416492515649;6491.091247225392;6523.6738163091895;6523.902141467882;6051.4553690168095;6068.241469816273;6072.453479186895;6086.9391306087255;6097.847553811146;28569.571456427962;29299.853500732574;30004.399912001856;30261.69738302611;30297.848510757525;1954.4234450837037;1976.5651556657656;1985.7021446782953;1991.1836147179731;1992.1732481020358;19133.521661958424;19695.31066412683;19707;19785.10967006488;19798.70301945472;2291.232437133562;2332.8716920569364;2343.6718859359703;2344.109238489363;2419.830611857171;132085;138481.61518384787;139064;139346;139551;14337.713245735027;15165.601975427002;15205.239738013277;15223;15238.619034524225;22797.544049118926;23768.88115559411;23947.401314966915;23957.52084958291;23960;9685.467299298607;9775.755606109762;9894.812622485348;9962.900370996342;10015.599376024877;9089.091090890857;9148.268138549034;9197.310201734897;9373.671921482852;9390.34267601275;8706.303495720455;8837.867431988525;8849.64601415949;8966.775830604287;8974.461532308082;2701.4462035283113;2717.728227177306;2741.4105967216747;2777.7222277772466;2934.090431966097;951.1202138022302;959.044334681621;964.4068897628049;989.6833013435631;991.8016396720685;19356.806431935784;19442.70835937462;19584.412467625993;19646.21415143407;20385.184592616424;979.740368802268;1026.153423425662;1040.6669865643073;1046.7540128069897;1053.847192157133;10454.268201225994;10570.894291057144;10619.415932123808;11089.390083545482;11098.889011109946;451114;452855;457834;463791;470771;118156;120487;121701.39149304197;123604.38197808953;126261;1247.827042579972;1260.5273022616518;1290.071148772882;1293.9482420703066;1294.786360250567;20324.695129573363;20970;21585.568288634455;21612.351629451143;21664.566708666054;57024;58193.127103092644;58261;58372.70813645905;60135.39864601298;66735.31617095726;66963.33036669766;67886.66056669685;68506;68895.3110468909;14978.550643480714;15169;15249.542513724606;15360.539183824503;15392.692146157238;23818.16636417717;23981;23991.400214994766;24532.754672453048;24538.386540336633;18640.533986650444;18694.439166825017;18725.25098996025;18995.90502047481;19012.809871901103;15583.376664933276;16850.57873553171;17565.297388104846;17618.911905440902;17933.910330448263;18632.720509192644;20166;20278.59442811165;20349.287774927805;20377.592448151252;14776.704465910836;14869.107853528823;15086.094834309977;15182.620434488785;15188.924055379652;18578.44264672062;18931.242750289835;19016.52458688544;19236.903815480833;19241.711374329676 10:21:12 INFO - PID 28460 | |3;mootools.html;1377.6073818961595;1434.1323499282933;1456.6212784675981;1462.5027490653179;1466.5600319904026;13174.73650526989;13705.451781928736;13761.44954201832;13794.655133621665;13798.241096739675;14037.859621403783;14480.782788258184;14576.125432474058;14650.34073466694;14652.926735366309;2514.170323793144;2583.599542070982;2592.2482480080753;2593.533164030474;2594.4681340325283;2542.9745702542923;2624.1078033468616;2627.0542604662305;2627.605859121128;2627.81605287629;2549.4391233928504;2555.540002799495;2566.3840678237275;2568.0626571301527;2568.5761849294936;2476.6408870713735;2528.0014394314235;2546.732593077728;2547.694276686791;2595.8053146014126;2492.626106084102;2496.7378425265447;2519.7858182054547;2521.13021007752;2533.936651583707;13148.6712832179;13394.866051339459;13425.530106446227;13450;13560.728785424237;7040.366367026941;7283.854322913565;7309.597972111532;7329.523580967273;7333;4726.550977657117;4790.880227994293;4851.393575803025;4870.099031679115;4885.877853053702;1850.1119462658;1857.2849452960706;1876.6809642360831;1884.387574038443;1916.93290734825;21474.89262553693;22238.555228895333;22456;22467.101315947344;22479.88760056189;6473.579217350857;6570.737170513126;6699.062131301622;6739.730410783513;6769.898451523132;17528.82471175272;17628.735568966476;17652;17690.911545442446;17693.20380582877;7256.165540962751;7481.7755467336065;7486.85026299471;7490.250974902466;7495.250474952461;5417.783288668488;6106.267247930188;6708.362705543063;6910.170779506391;6926.307369263033;5062.924056139161;5266.947330526646;5269.420363759983;5276.208568714646;5309.150535914235;1571.3714514194185;1584.4058478070724;1609.2597405193508;1618.5236588020348;1632.5102469259411;880.423322723617;901.8466860633708;919.1497864475333;947.8720372749729;949.6154057606681;7020.262872398427;7447.106347238366;7453.217412171753;7483.32650061497;8274.917250827535;688.4595592459995;732.7691777090199;734.4491631276543;746.1792028768311;750.2235186581862;4391.626711729475;5224.582033437316;5233.450487698813;5268.499492548279;5422.43064478232;18104.456866294033;18884.43346699601;18897.81102188988;18940.905295473436;18975.71536426955;17979;18394;18528.907355463136;18671.439856804045;18722.719159212622;10375.584976601003;10567.682969510926;10769.353838769699;10769.623063192907;10797.08224800885;7590.127135379281;7816.53100813953;7935.563544005136;8024.996875390576;8049.27556519916;16045.598860028593;16281.918590406973;16307.429239976544;16349.18254087267;16761.329546818477;12972.67568310762;15872;16724.83275167233;16794.160291985598;17227.91386043112;10454.222645951459;11151.219414640897;11179.66461006171;11186.105111591216;11199.440027998731;12575.434105465092;12659.873401266237;12680.492780288685;12796.36018199105;12872.742545148858;10121.848172277569;10335.896641033494;10430.68707938763;10629.787404252027;10814.972577605115;9990.450525221182;10175.949120254352;10232.846507302247;10388.844167337647;10470.476476176313;9217.723468295962;9267.629294828132;9271.211946984582;9400.670976515788;9446.338756286994;6788.796336109925;6821.897671534832;7085.929140708527;7209.35115839577;7243.022192004223;7250.854982900207;7267.200607933229;7273.854522909406;7275.417966562556;7418.369438597564 10:21:12 INFO - PID 28460 | |4;prototype.html;447;461.4485689600928;484.665580749283;487.9971658242313;492.4066499867658;6074.635521868691;6093.750781089877;6107.450329470346;6129.325774164844;6187.319394866567;5842.357340692531;5908.940910590893;5933.821985340436;5984.251968503937;6011.338752737195;4883.682560633565;4886.706797592147;4895.290182923474;4912.582430493412;4931.211006239003;4768.403949506312;4895.265710143472;4918.852434426973;4930.580900623451;4954.900901981958;4842.806287748486;4851.708897466146;4860.951390486085;4864.635152363569;4871.468185565454;4855.975720121394;4867.2212446008825;4891.779869905863;4893.6329775266995;4899.58353539946;4325.480942286914;4338;4340.52254252032;4364.170807546556;4364.756044527327;5844.853878653025;5853.414658534155;5882.941170588282;5915.201447804534;5989.970050149721;5499.807506737285;5559.221708960748;5589.245451864028;5598.608097433141;5642.181883626892;6356.745730170787;6389.817883691532;6412.551121421502;6446.743639726105;6476.481881449473;4686.929696054562;4728.574428301435;4751.762411879392;4776.020915712271;4798.424189097295;6801.523893327469;6850.4862135340045;6869.278725733826;6883.208431030395;6896.724131034753;4910.48439913811;4943.456219815817;4950.985048065138;4962.206047032458;4962.826301079445;4878.268259761065;4953.455119936804;4963.205887058053;5002.473750755845;5027.874303142451;5528.530074943595;5576.163575463713;5624.55003599711;5626.324841019104;5649.406812284651;6428.4857211423905;6441.066045423388;6445.2265728112925;6446.903296450557;6462.4183823456115;1643.5644554193148;1679.706051440993;1717.8625709943174;1863.7856646485827;1872.7190921361905;1415.1296952374216;1417.9574612761633;1430.1204759073096;1431.9642008949859;1446.5877224990827;5493.670379777226;5635;5644.407337229614;5646.350669672958;5665.745041473144;6347.650879201688;6432.719313150327;6473.385028422293;6549.443297319781;6629.7679581214425;5613.214150018919;5615.298087739033;5621.128725047624;5632.408597097327;5655.632383895034;3483.965160348364;3489.965100348964;3504.421770407905;3537.398642230827;3537.814832031247;6359.618422894641;6362.745490180433;6385.48916086712;6443.387878151568;6452.35476452351;6723.924172132435;6762.898556521656;6781.287964763727;6804.149481314836;6833.829154271183;6418.839529011812;6426.582272152295;6456.0961465394885;6471.352864713585;6504.38208370204;6568.916128838688;6629.337066293332;6645.534812563074;6653.502961833548;6671.166104236971;6495.870082598416;6550.508711846535;6571.967140164268;6582.868342633024;6603.641596546257;6353.633968696752;6435.22777266731;6439.293587199302;6455.741770329134;6496.350364963466;4813;4876.780544875418;4896.951030489649;4908.975455122844;4912.680675756064;6307.400796924285;6368.617882927039;6565.146530950946;6599.1953419797355;6611.537192396486;6259.749610015549;6354.3963323484195;6365.267994180728;6390.808275751735;6432.581882177644;6459.61242325462;6460.870782584416;6467.805965821033;6473.514486413444;6473.838154046187;6319.210098737658;6349.650629267201;6369.331220221995;6392.3927226913365;6439.484841212598;6409.353218916249;6446.226452825504;6467.15926929515;6468.2859042352875;6469.061986011908;6228.532860035425;6263.841189379979;6267.185265915584;6272.874542509033;6292.024736165901 10:21:12 INFO - PID 28460 | |5;yui.html;909.1136142261296;929.2333824594709;941.1529623338989;950.710033439801;950.9334346595739;17386.82613173868;18708.625827483444;18717.157727902242;18729.531761705948;18801.623967520674;17783.199756010978;19140.712889306673;19145.32991345303;19200.327988520403;19214.807851921476;1020.8979102089787;1038.7662775875406;1041.3023274406166;1047.9842802357932;1048.4390850894772;983.4640121133999;1065.690949624608;1069.2408390043079;1074.9946250268777;1076.8277075667895;1098.906592939601;1104.4367372639972;1105.7622611138604;1106.7454485468347;1107.640016994476;1096.8245080787035;1098.3739268616891;1100.2023532938636;1101.581399068353;1102.4653043274006;806.4475834053692;806.891069705588;811.342812322021;812.2080971053235;812.4191203289618;19474.123664434992;19853.205871765113;20046.09792559338;20100.396988090233;20226.19095236189;20150.798492015187;20645.380638580868;20683.793162068338;21061.47346316339;21087.261945831822;15797.92101039499;16239.594010149722;16314.428994985119;16374.181290935405;16460.259288331934;3602.0274525877867;3619.2218672985437;3621.474886141521;3623.076115590534;3624.4925710400566;121446.71212741845;125456.37271813674;128746;129442.3527882364;130364;15351.92324038395;16060.116693581731;16203;16445.58886027859;16454.75317870233;31039;31127.066188014396;31236.531452028237;31771.52342714861;31899.52150717741;8416.621252043673;8649.394542382099;8666.956665216634;8689.217970382695;8696.478211307342;4052;4077.4699289092227;4109.0549173690215;4130.91738165235;4133.090720041586;4918.483559226302;5132.101882170605;5133.614978876599;5135.15269980449;5138.229265610188;996.2179688944144;1001.9749506262402;1010.5149528226492;1015.081351377005;1020.7346090016649;678.494521581425;683.6650041479639;686.8385929306609;714.310690183975;722.5917356693451;12045.21706089119;12127.514899404101;13088.149270297401;13862.93068534651;14056;702.5257950883133;708.2917082917083;712.9572225666477;715.7602203261862;723.5730918757853;5259.815906443333;5508.366537848118;5628.352739434936;5653.802116925888;5678.375378708339;100231.36002718397;100669.9799006031;102010.48994754978;104173.47913260385;104248;86289;89506.55246723855;92704.53647731718;94707;95756;73683;75553.24446755572;79591;79839.60080199562;79848;10678.786424271315;10795.40625265618;11026.669199924016;11264.774704506028;11286;33167.66832331646;35125;35775.82112089423;36075.45886811752;37027.81486092552;42366.5763342375;44550;44744.328835068154;44770.77614611906;45353.77323113364;16010.19949002522;18845;19465.221391144194;19590.236878680986;19716.704249436556;20499.59000820005;20817.791822081585;21473.570528589655;21535.353939381843;22272.10911563584;18984.671073024754;19139;19339;19350.903245484245;19510.8048919509;17497.21262543163;17543.82456175473;17604.119794010505;17642.82357176412;19326.130324135167;17729.37947171843;17936.192871321084;18267.54331141732;18312.26750929948;18517.722234166227;12611.369431528203;13581.86418135806;13796.379162937492;13840.792388113985;13846.515371961934;14084.01411901157;15156.317965691349;15246.466373676869;15384.923075384551;15423.305951232445 10:21:12 INFO - PID 28460 | __end_tp_report 10:21:12 INFO - PID 28460 | __start_cc_report 10:21:12 INFO - PID 28460 | _x_x_mozilla_cycle_collect,361 10:21:12 INFO - PID 28460 | __end_cc_report 10:21:12 INFO - PID 28460 | __startTimestamp1500484872314__endTimestamp 10:21:12 INFO - PID 28460 | 10:21:12 INFO - PID 28460 | ------- Summary: start ------- 10:21:12 INFO - PID 28460 | Number of tests: 6 10:21:12 INFO - PID 28460 | 10:21:12 INFO - PID 28460 | [#0] dojo.html Cycles:165 Average:6052.14 Median:6301.34 stddev:717.33 (11.4%) stddev-sans-first:679.55 10:21:12 INFO - PID 28460 | Values: 3042.0 3104.5 3105.2 3109.6 3139.1 6020.8 6090.7 6132.6 6150.8 6185.6 6099.9 6124.4 6129.8 6140.9 6146.9 5510.9 5585.4 5594.9 5612.4 5684.0 5654.2 5658.8 5672.5 5713.9 5716.2 5409.5 5521.6 5588.2 5615.0 5622.7 5524.7 5584.9 5612.6 5621.6 5626.0 5462.3 5489.8 5552.8 5554.1 5564.6 5860.2 5979.1 6013.2 6026.6 6027.6 6467.6 6498.7 6548.7 6555.2 6575.5 6547.1 6557.5 6627.0 6639.4 6657.9 6021.9 6072.1 6117.6 6169.2 6200.3 6777.5 6852.5 6864.3 6866.2 6867.3 6468.1 6484.5 6543.5 6545.5 6551.6 6357.0 6508.3 6523.2 6528.3 6621.8 6494.6 6574.6 6577.6 6618.7 6622.6 6516.3 6529.4 6620.7 6625.7 6632.0 5239.3 5341.9 5347.8 5349.1 5399.2 4502.9 4542.8 4573.3 4610.9 4638.2 5684.3 5738.9 5744.5 5752.5 5758.5 6584.4 6590.5 6611.1 6682.8 6689.3 5581.5 5658.9 5664.0 5738.5 5762.4 5862.0 5905.1 5912.3 5916.8 5917.4 6362.1 6378.6 6396.9 6467.8 6478.9 6473.7 6505.2 6540.1 6561.0 6660.6 6401.9 6418.3 6443.0 6459.7 6463.2 6455.9 6483.4 6496.5 6566.2 6574.4 6530.9 6560.7 6590.5 6627.2 6673.8 6296.7 6301.3 6309.0 6409.1 6427.2 6346.0 6352.4 6413.3 6422.1 6444.0 6237.5 6301.3 6381.4 6399.2 6401.6 6377.8 6433.4 6442.0 6516.4 6555.0 6124.8 6155.1 6260.3 6300.8 6312.1 10:21:12 INFO - PID 28460 | 10:21:12 INFO - PID 28460 | [#1] ext.html Cycles:180 Average:38662.02 Median:38285.85 stddev:53721.56 (140.3%) stddev-sans-first:53796.91 10:21:12 INFO - PID 28460 | Values: 768.5 770.5 781.9 801.3 817.9 43479.8 43616.3 43760.0 44224.8 44261.1 38513.0 38594.2 38675.2 38782.4 38814.8 6863.8 7012.9 7015.6 7016.2 7018.1 6888.4 6975.4 6983.4 6985.6 6987.1 6939.9 7390.6 7991.0 8008.9 8017.6 7919.5 7972.7 7973.4 7977.0 7984.0 7607.1 7841.2 7880.8 7905.4 7932.3 40239.6 40643.2 40723.8 40749.4 40772.2 3510.5 3536.6 3556.1 3561.7 3568.8 32433.7 32555.5 32674.7 32685.5 32712.2 4878.9 4884.2 4887.7 4905.2 4918.0 180522.1 185217.0 185471.0 187172.1 233003.0 52274.7 52899.0 52950.0 52974.2 53109.2 54409.2 54449.5 54681.7 55027.0 55090.4 16504.0 16518.0 16532.2 16555.0 16595.3 13458.1 13561.7 13562.7 13567.9 13578.0 14960.3 15017.6 15168.0 15174.2 15290.6 5964.4 6009.2 6072.5 6101.7 6156.1 980.7 989.1 1002.9 1018.5 1033.9 22600.9 22782.3 23569.3 26906.3 28382.4 1098.2 1118.0 1124.7 1136.1 1137.5 12315.8 12592.8 12598.3 12645.7 12681.5 231086.0 232938.0 233241.0 233680.0 234134.0 55760.2 55899.4 56007.4 56221.4 56299.2 1446.9 1486.5 1497.3 1506.6 1528.9 22271.4 22556.9 22875.1 22970.3 23433.3 38186.8 38384.9 38417.4 38496.0 38625.0 189442.0 189798.0 190224.0 190828.0 191120.0 36833.8 37873.0 38660.8 39320.8 39565.0 48813.0 50144.0 50262.5 50326.2 50482.7 33106.5 34850.3 35057.3 35099.8 35425.1 33809.3 33823.0 34441.0 34653.0 35080.5 38431.0 38443.6 38527.2 38651.2 39029.6 33344.7 33713.7 33882.0 34299.8 34641.1 24032.9 24048.0 24699.5 24921.4 25048.5 10:21:12 INFO - PID 28460 | 10:21:12 INFO - PID 28460 | [#2] jquery.html Cycles:180 Average:34301.72 Median:23793.52 stddev:77977.76 (327.7%) stddev-sans-first:78155.37 10:21:12 INFO - PID 28460 | Values: 565.9 571.2 572.8 576.4 593.2 22404.6 22581.5 23413.3 23414.6 23455.4 25934.5 26330.7 26465.6 26478.9 26537.3 6502.4 6655.6 6657.8 6675.8 6685.3 6280.8 6563.9 6572.1 6630.9 6683.2 6525.1 6528.3 6538.2 6542.6 6565.5 6464.2 6483.4 6491.1 6523.7 6523.9 6051.5 6068.2 6072.5 6086.9 6097.8 28569.6 29299.9 30004.4 30261.7 30297.8 1954.4 1976.6 1985.7 1991.2 1992.2 19133.5 19695.3 19707.0 19785.1 19798.7 2291.2 2332.9 2343.7 2344.1 2419.8 132085.0 138481.6 139064.0 139346.0 139551.0 14337.7 15165.6 15205.2 15223.0 15238.6 22797.5 23768.9 23947.4 23957.5 23960.0 9685.5 9775.8 9894.8 9962.9 10015.6 9089.1 9148.3 9197.3 9373.7 9390.3 8706.3 8837.9 8849.6 8966.8 8974.5 2701.4 2717.7 2741.4 2777.7 2934.1 951.1 959.0 964.4 989.7 991.8 19356.8 19442.7 19584.4 19646.2 20385.2 979.7 1026.2 1040.7 1046.8 1053.8 10454.3 10570.9 10619.4 11089.4 11098.9 451114.0 452855.0 457834.0 463791.0 470771.0 118156.0 120487.0 121701.4 123604.4 126261.0 1247.8 1260.5 1290.1 1293.9 1294.8 20324.7 20970.0 21585.6 21612.4 21664.6 57024.0 58193.1 58261.0 58372.7 60135.4 66735.3 66963.3 67886.7 68506.0 68895.3 14978.6 15169.0 15249.5 15360.5 15392.7 23818.2 23981.0 23991.4 24532.8 24538.4 18640.5 18694.4 18725.3 18995.9 19012.8 15583.4 16850.6 17565.3 17618.9 17933.9 18632.7 20166.0 20278.6 20349.3 20377.6 14776.7 14869.1 15086.1 15182.6 15188.9 18578.4 18931.2 19016.5 19236.9 19241.7 10:21:12 INFO - PID 28460 | 10:21:12 INFO - PID 28460 | [#3] mootools.html Cycles:180 Average:8538.01 Median:2530.97 stddev:5804.00 (229.3%) stddev-sans-first:5795.35 10:21:12 INFO - PID 28460 | Values: 1377.6 1434.1 1456.6 1462.5 1466.6 13174.7 13705.5 13761.4 13794.7 13798.2 14037.9 14480.8 14576.1 14650.3 14652.9 2514.2 2583.6 2592.2 2593.5 2594.5 2543.0 2624.1 2627.1 2627.6 2627.8 2549.4 2555.5 2566.4 2568.1 2568.6 2476.6 2528.0 2546.7 2547.7 2595.8 2492.6 2496.7 2519.8 2521.1 2533.9 13148.7 13394.9 13425.5 13450.0 13560.7 7040.4 7283.9 7309.6 7329.5 7333.0 4726.6 4790.9 4851.4 4870.1 4885.9 1850.1 1857.3 1876.7 1884.4 1916.9 21474.9 22238.6 22456.0 22467.1 22479.9 6473.6 6570.7 6699.1 6739.7 6769.9 17528.8 17628.7 17652.0 17690.9 17693.2 7256.2 7481.8 7486.9 7490.3 7495.3 5417.8 6106.3 6708.4 6910.2 6926.3 5062.9 5266.9 5269.4 5276.2 5309.2 1571.4 1584.4 1609.3 1618.5 1632.5 880.4 901.8 919.1 947.9 949.6 7020.3 7447.1 7453.2 7483.3 8274.9 688.5 732.8 734.4 746.2 750.2 4391.6 5224.6 5233.5 5268.5 5422.4 18104.5 18884.4 18897.8 18940.9 18975.7 17979.0 18394.0 18528.9 18671.4 18722.7 10375.6 10567.7 10769.4 10769.6 10797.1 7590.1 7816.5 7935.6 8025.0 8049.3 16045.6 16281.9 16307.4 16349.2 16761.3 12972.7 15872.0 16724.8 16794.2 17227.9 10454.2 11151.2 11179.7 11186.1 11199.4 12575.4 12659.9 12680.5 12796.4 12872.7 10121.8 10335.9 10430.7 10629.8 10815.0 9990.5 10175.9 10232.8 10388.8 10470.5 9217.7 9267.6 9271.2 9400.7 9446.3 6788.8 6821.9 7085.9 7209.4 7243.0 7250.9 7267.2 7273.9 7275.4 7418.4 10:21:12 INFO - PID 28460 | 10:21:12 INFO - PID 28460 | [#4] prototype.html Cycles:180 Average:5412.58 Median:5924.51 stddev:1503.29 (25.4%) stddev-sans-first:1460.57 10:21:12 INFO - PID 28460 | Values: 447.0 461.4 484.7 488.0 492.4 6074.6 6093.8 6107.5 6129.3 6187.3 5842.4 5908.9 5933.8 5984.3 6011.3 4883.7 4886.7 4895.3 4912.6 4931.2 4768.4 4895.3 4918.9 4930.6 4954.9 4842.8 4851.7 4861.0 4864.6 4871.5 4856.0 4867.2 4891.8 4893.6 4899.6 4325.5 4338.0 4340.5 4364.2 4364.8 5844.9 5853.4 5882.9 5915.2 5990.0 5499.8 5559.2 5589.2 5598.6 5642.2 6356.7 6389.8 6412.6 6446.7 6476.5 4686.9 4728.6 4751.8 4776.0 4798.4 6801.5 6850.5 6869.3 6883.2 6896.7 4910.5 4943.5 4951.0 4962.2 4962.8 4878.3 4953.5 4963.2 5002.5 5027.9 5528.5 5576.2 5624.6 5626.3 5649.4 6428.5 6441.1 6445.2 6446.9 6462.4 1643.6 1679.7 1717.9 1863.8 1872.7 1415.1 1418.0 1430.1 1432.0 1446.6 5493.7 5635.0 5644.4 5646.4 5665.7 6347.7 6432.7 6473.4 6549.4 6629.8 5613.2 5615.3 5621.1 5632.4 5655.6 3484.0 3490.0 3504.4 3537.4 3537.8 6359.6 6362.7 6385.5 6443.4 6452.4 6723.9 6762.9 6781.3 6804.1 6833.8 6418.8 6426.6 6456.1 6471.4 6504.4 6568.9 6629.3 6645.5 6653.5 6671.2 6495.9 6550.5 6572.0 6582.9 6603.6 6353.6 6435.2 6439.3 6455.7 6496.4 4813.0 4876.8 4897.0 4909.0 4912.7 6307.4 6368.6 6565.1 6599.2 6611.5 6259.7 6354.4 6365.3 6390.8 6432.6 6459.6 6460.9 6467.8 6473.5 6473.8 6319.2 6349.7 6369.3 6392.4 6439.5 6409.4 6446.2 6467.2 6468.3 6469.1 6228.5 6263.8 6267.2 6272.9 6292.0 10:21:12 INFO - PID 28460 | 10:21:12 INFO - PID 28460 | [#5] yui.html Cycles:180 Average:22330.55 Median:19492.46 stddev:29952.85 (153.7%) stddev-sans-first:29993.69 10:21:12 INFO - PID 28460 | Values: 909.1 929.2 941.2 950.7 950.9 17386.8 18708.6 18717.2 18729.5 18801.6 17783.2 19140.7 19145.3 19200.3 19214.8 1020.9 1038.8 1041.3 1048.0 1048.4 983.5 1065.7 1069.2 1075.0 1076.8 1098.9 1104.4 1105.8 1106.7 1107.6 1096.8 1098.4 1100.2 1101.6 1102.5 806.4 806.9 811.3 812.2 812.4 19474.1 19853.2 20046.1 20100.4 20226.2 20150.8 20645.4 20683.8 21061.5 21087.3 15797.9 16239.6 16314.4 16374.2 16460.3 3602.0 3619.2 3621.5 3623.1 3624.5 121446.7 125456.4 128746.0 129442.4 130364.0 15351.9 16060.1 16203.0 16445.6 16454.8 31039.0 31127.1 31236.5 31771.5 31899.5 8416.6 8649.4 8667.0 8689.2 8696.5 4052.0 4077.5 4109.1 4130.9 4133.1 4918.5 5132.1 5133.6 5135.2 5138.2 996.2 1002.0 1010.5 1015.1 1020.7 678.5 683.7 686.8 714.3 722.6 12045.2 12127.5 13088.1 13862.9 14056.0 702.5 708.3 713.0 715.8 723.6 5259.8 5508.4 5628.4 5653.8 5678.4 100231.4 100670.0 102010.5 104173.5 104248.0 86289.0 89506.6 92704.5 94707.0 95756.0 73683.0 75553.2 79591.0 79839.6 79848.0 10678.8 10795.4 11026.7 11264.8 11286.0 33167.7 35125.0 35775.8 36075.5 37027.8 42366.6 44550.0 44744.3 44770.8 45353.8 16010.2 18845.0 19465.2 19590.2 19716.7 20499.6 20817.8 21473.6 21535.4 22272.1 18984.7 19139.0 19339.0 19350.9 19510.8 17497.2 17543.8 17604.1 17642.8 19326.1 17729.4 17936.2 18267.5 18312.3 18517.7 12611.4 13581.9 13796.4 13840.8 13846.5 14084.0 15156.3 15246.5 15384.9 15423.3 10:21:12 INFO - PID 28460 | -------- Summary: end -------- 10:21:12 INFO - PID 28460 | 10:21:13 INFO - TEST-INFO | 28460: exit 0 10:21:13 INFO - TEST-OK | dromaeo_css | took 1112760ms 10:21:13 INFO - TEST-START | kraken 10:21:13 INFO - Initialising browser for kraken test... 10:21:13 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50260/getInfo.html -profile /tmp/tmpj9nFuo/profile 10:21:13 INFO - TEST-INFO | started process 28827 (/builds/slave/test/build/application/firefox/firefox http://localhost:50260/getInfo.html) 10:21:18 INFO - TEST-INFO | 28827: exit 0 10:21:19 INFO - Browser initialized. 10:21:19 INFO - Running cycle 1/1 for kraken test... 10:21:19 INFO - TEST-INFO | started process 29039 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj9nFuo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:21:30 INFO - PID 29039 | RSS: Main: 175796224 10:21:30 INFO - PID 29039 | 10:21:33 INFO - PID 29039 | Cycle 1(1): loaded http://localhost:50260/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50260/tests/kraken/driver.html?testName=audio-beat-detection) 10:21:34 INFO - PID 29039 | RSS: Main: 180129792 10:21:34 INFO - PID 29039 | 10:21:36 INFO - PID 29039 | Cycle 1(1): loaded http://localhost:50260/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50260/tests/kraken/driver.html?testName=audio-dft) 10:21:37 INFO - PID 29039 | RSS: Main: 180760576 10:21:37 INFO - PID 29039 | 10:21:40 INFO - PID 29039 | Cycle 1(1): loaded http://localhost:50260/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50260/tests/kraken/driver.html?testName=audio-fft) 10:21:41 INFO - PID 29039 | RSS: Main: 175038464 10:21:41 INFO - PID 29039 | 10:21:43 INFO - PID 29039 | Cycle 1(1): loaded http://localhost:50260/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50260/tests/kraken/driver.html?testName=audio-oscillator) 10:21:43 INFO - PID 29039 | RSS: Main: 175169536 10:21:43 INFO - PID 29039 | 10:21:46 INFO - PID 29039 | Cycle 1(1): loaded http://localhost:50260/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50260/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:21:46 INFO - PID 29039 | RSS: Main: 176156672 10:21:46 INFO - PID 29039 | 10:21:49 INFO - PID 29039 | Cycle 1(1): loaded http://localhost:50260/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50260/tests/kraken/driver.html?testName=imaging-darkroom) 10:21:50 INFO - PID 29039 | RSS: Main: 178745344 10:21:50 INFO - PID 29039 | 10:21:53 INFO - PID 29039 | Cycle 1(1): loaded http://localhost:50260/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50260/tests/kraken/driver.html?testName=imaging-desaturate) 10:21:54 INFO - PID 29039 | RSS: Main: 178364416 10:21:54 INFO - PID 29039 | 10:21:57 INFO - PID 29039 | Cycle 1(1): loaded http://localhost:50260/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50260/tests/kraken/driver.html?testName=json-parse-financial) 10:21:57 INFO - PID 29039 | RSS: Main: 178524160 10:21:57 INFO - PID 29039 | 10:21:59 INFO - PID 29039 | Cycle 1(1): loaded http://localhost:50260/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50260/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:22:00 INFO - PID 29039 | RSS: Main: 179089408 10:22:00 INFO - PID 29039 | 10:22:01 INFO - PID 29039 | Cycle 1(1): loaded http://localhost:50260/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50260/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:22:02 INFO - PID 29039 | RSS: Main: 176152576 10:22:02 INFO - PID 29039 | 10:22:04 INFO - PID 29039 | Cycle 1(1): loaded http://localhost:50260/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50260/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:22:05 INFO - PID 29039 | RSS: Main: 176660480 10:22:05 INFO - PID 29039 | 10:22:08 INFO - PID 29039 | Cycle 1(1): loaded http://localhost:50260/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50260/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:22:08 INFO - PID 29039 | RSS: Main: 176455680 10:22:08 INFO - PID 29039 | 10:22:11 INFO - PID 29039 | Cycle 1(1): loaded http://localhost:50260/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50260/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:22:12 INFO - PID 29039 | RSS: Main: 176365568 10:22:12 INFO - PID 29039 | 10:22:14 INFO - PID 29039 | Cycle 1(1): loaded http://localhost:50260/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50260/tests/kraken/driver.html?testName=ai-astar) 10:22:14 INFO - PID 29039 | RSS: Main: 177799168 10:22:14 INFO - PID 29039 | 10:22:14 INFO - PID 29039 | __start_tp_report 10:22:14 INFO - PID 29039 | _x_x_mozilla_page_load 10:22:14 INFO - PID 29039 | _x_x_mozilla_page_load_details 10:22:14 INFO - PID 29039 | |i|pagename|runs| 10:22:14 INFO - PID 29039 | |0;ai-astar;100;111;103;109;110;111;110;102;111;112 10:22:14 INFO - PID 29039 | |1;audio-beat-detection;152;120;142;187;119;149;149;123;177;122 10:22:14 INFO - PID 29039 | |2;audio-dft;164;165;164;165;166;164;167;165;169;165 10:22:14 INFO - PID 29039 | |3;audio-fft;76;74;76;107;77;77;75;94;100;81 10:22:14 INFO - PID 29039 | |4;audio-oscillator;81;82;139;80;79;80;139;83;82;142 10:22:14 INFO - PID 29039 | |5;imaging-gaussian-blur;114;114;114;114;114;113;114;114;114;116 10:22:14 INFO - PID 29039 | |6;imaging-darkroom;154;151;151;151;150;151;151;151;150;150 10:22:14 INFO - PID 29039 | |7;imaging-desaturate;94;95;94;95;94;94;95;94;95;94 10:22:14 INFO - PID 29039 | |8;json-parse-financial;57;60;55;55;55;54;61;55;55;56 10:22:14 INFO - PID 29039 | |9;json-stringify-tinderbox;55;56;55;54;54;55;54;54;55;55 10:22:14 INFO - PID 29039 | |10;stanford-crypto-aes;79;76;86;78;79;79;77;77;88;85 10:22:14 INFO - PID 29039 | |11;stanford-crypto-ccm;127;131;126;129;130;125;138;129;127;169 10:22:14 INFO - PID 29039 | |12;stanford-crypto-pbkdf2;181;179;180;194;178;186;180;190;180;188 10:22:14 INFO - PID 29039 | |13;stanford-crypto-sha256-iterative;69;70;69;74;71;71;68;68;70;68 10:22:14 INFO - PID 29039 | __end_tp_report 10:22:14 INFO - PID 29039 | __start_cc_report 10:22:14 INFO - PID 29039 | _x_x_mozilla_cycle_collect,966 10:22:14 INFO - PID 29039 | __end_cc_report 10:22:14 INFO - PID 29039 | __startTimestamp1500484934620__endTimestamp 10:22:14 INFO - PID 29039 | 10:22:14 INFO - PID 29039 | ------- Summary: start ------- 10:22:14 INFO - PID 29039 | Number of tests: 14 10:22:14 INFO - PID 29039 | 10:22:14 INFO - PID 29039 | [#0] ai-astar Cycles:10 Average:107.90 Median:110.50 stddev:4.43 (4.0%) stddev-sans-first:3.67 10:22:14 INFO - PID 29039 | Values: 100.0 111.0 103.0 109.0 110.0 111.0 110.0 102.0 111.0 112.0 10:22:14 INFO - PID 29039 | 10:22:14 INFO - PID 29039 | [#1] audio-beat-detection Cycles:10 Average:144.00 Median:149.00 stddev:24.00 (16.1%) stddev-sans-first:25.28 10:22:14 INFO - PID 29039 | Values: 152.0 120.0 142.0 187.0 119.0 149.0 149.0 123.0 177.0 122.0 10:22:14 INFO - PID 29039 | 10:22:14 INFO - PID 29039 | [#2] audio-dft Cycles:10 Average:165.40 Median:165.00 stddev:1.58 (1.0%) stddev-sans-first:1.59 10:22:14 INFO - PID 29039 | Values: 164.0 165.0 164.0 165.0 166.0 164.0 167.0 165.0 169.0 165.0 10:22:14 INFO - PID 29039 | 10:22:14 INFO - PID 29039 | [#3] audio-fft Cycles:10 Average:83.70 Median:76.50 stddev:12.02 (15.7%) stddev-sans-first:12.42 10:22:14 INFO - PID 29039 | Values: 76.0 74.0 76.0 107.0 77.0 77.0 75.0 94.0 100.0 81.0 10:22:14 INFO - PID 29039 | 10:22:14 INFO - PID 29039 | [#4] audio-oscillator Cycles:10 Average:98.70 Median:80.50 stddev:28.53 (35.4%) stddev-sans-first:29.54 10:22:14 INFO - PID 29039 | Values: 81.0 82.0 139.0 80.0 79.0 80.0 139.0 83.0 82.0 142.0 10:22:14 INFO - PID 29039 | 10:22:14 INFO - PID 29039 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 10:22:14 INFO - PID 29039 | Values: 114.0 114.0 114.0 114.0 114.0 113.0 114.0 114.0 114.0 116.0 10:22:14 INFO - PID 29039 | 10:22:14 INFO - PID 29039 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:151.00 stddev:1.15 (0.8%) stddev-sans-first:0.50 10:22:14 INFO - PID 29039 | Values: 154.0 151.0 151.0 151.0 150.0 151.0 151.0 151.0 150.0 150.0 10:22:14 INFO - PID 29039 | 10:22:14 INFO - PID 29039 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 10:22:14 INFO - PID 29039 | Values: 94.0 95.0 94.0 95.0 94.0 94.0 95.0 94.0 95.0 94.0 10:22:14 INFO - PID 29039 | 10:22:14 INFO - PID 29039 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:55.50 stddev:2.36 (4.3%) stddev-sans-first:2.49 10:22:14 INFO - PID 29039 | Values: 57.0 60.0 55.0 55.0 55.0 54.0 61.0 55.0 55.0 56.0 10:22:14 INFO - PID 29039 | 10:22:14 INFO - PID 29039 | [#9] json-stringify-tinderbox Cycles:10 Average:54.70 Median:55.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 10:22:14 INFO - PID 29039 | Values: 55.0 56.0 55.0 54.0 54.0 55.0 54.0 54.0 55.0 55.0 10:22:14 INFO - PID 29039 | 10:22:14 INFO - PID 29039 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:79.00 stddev:4.27 (5.4%) stddev-sans-first:4.50 10:22:14 INFO - PID 29039 | Values: 79.0 76.0 86.0 78.0 79.0 79.0 77.0 77.0 88.0 85.0 10:22:14 INFO - PID 29039 | 10:22:14 INFO - PID 29039 | [#11] stanford-crypto-ccm Cycles:10 Average:133.10 Median:129.50 stddev:13.13 (10.1%) stddev-sans-first:13.74 10:22:14 INFO - PID 29039 | Values: 127.0 131.0 126.0 129.0 130.0 125.0 138.0 129.0 127.0 169.0 10:22:14 INFO - PID 29039 | 10:22:14 INFO - PID 29039 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.60 Median:183.50 stddev:5.50 (3.0%) stddev-sans-first:5.75 10:22:14 INFO - PID 29039 | Values: 181.0 179.0 180.0 194.0 178.0 186.0 180.0 190.0 180.0 188.0 10:22:14 INFO - PID 29039 | 10:22:14 INFO - PID 29039 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.00 stddev:1.87 (2.7%) stddev-sans-first:1.96 10:22:14 INFO - PID 29039 | Values: 69.0 70.0 69.0 74.0 71.0 71.0 68.0 68.0 70.0 68.0 10:22:14 INFO - PID 29039 | -------- Summary: end -------- 10:22:14 INFO - PID 29039 | 10:22:15 INFO - PID 29039 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 10:22:15 INFO - TEST-INFO | 29039: exit 0 10:22:15 INFO - TEST-OK | kraken | took 62490ms 10:22:15 INFO - SUITE-END | took 1175s 10:22:15 INFO - Completed test suite (00:19:35) 10:22:15 INFO - javascript benchmark 10:22:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8425.57425783107, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3041.9999999999986, 3104.549840273159, 3105.1616063662814, 3109.626844778626, 3139.0896639974408, 6020.789272375468, 6090.695465226738, 6132.570720049598, 6150.81547553573, 6185.597936134153, 6099.939000609993, 6124.387561243873, 6129.754809807602, 6140.907886381697, 6146.938530614692, 5510.862228444281, 5585.413531579186, 5594.888102237953, 5612.35457922338, 5684.0, 5654.208410822488, 5658.8019419320335, 5672.489475947164, 5713.942860571383, 5716.228309178249, 5409.540189083893, 5521.641093328961, 5588.189712491686, 5615.045442274803, 5622.746976386073, 5524.696141712204, 5584.944150558483, 5612.550995920316, 5621.550275977953, 5626.043572592669, 5462.289902312714, 5489.835304940858, 5552.750126244328, 5554.0835762099205, 5564.610477266593, 5860.238169038041, 5979.133025711291, 6013.1581578579035, 6026.638401695912, 6027.578069535134, 6467.644279564622, 6498.740050397979, 6548.738050477975, 6555.180602424697, 6575.539712220147, 6547.116139321179, 6557.5081868860025, 6626.966865165691, 6639.3692599203, 6657.900131498031, 6021.909671354933, 6072.119542666333, 6117.632942023404, 6169.167162433104, 6200.255969283715, 6777.49168812341, 6852.45180385568, 6864.279250678706, 6866.244713081557, 6867.3476019778045, 6468.06213099098, 6484.513661475314, 6543.509236807258, 6545.509086818508, 6551.6069035858, 6357.014662727284, 6508.284088750233, 6523.249826269945, 6528.281888992207, 6621.768238111643, 6494.577852439576, 6574.638394888231, 6577.638229897306, 6618.7021584028835, 6622.602643841385, 6516.348365163446, 6529.444997175198, 6620.668966551653, 6625.668716564152, 6631.966840165865, 5239.345081864767, 5341.946580534222, 5347.839564813062, 5349.117395629678, 5399.217113518518, 4502.887427814266, 4542.795574199169, 4573.314002899525, 4610.861674149781, 4638.1883170445035, 5684.34630017545, 5738.942610573924, 5744.51171650406, 5752.539796816244, 5758.452946970031, 6584.374484423972, 6590.538662293689, 6611.074449577063, 6682.766103186463, 6689.297623749533, 5581.4976652100695, 5658.943410565924, 5663.9716801415725, 5738.454846789548, 5762.394948530427, 5862.032764593794, 5905.1142328650185, 5912.260967379078, 5916.822495325147, 5917.378675239038, 6362.0774987627465, 6378.649174295366, 6396.9040464394, 6467.773627923, 6478.902816457757, 6473.708683109366, 6505.186851643544, 6540.084388185753, 6561.048647946117, 6660.56706314088, 6401.935980640134, 6418.326075762165, 6442.967785161044, 6459.741610335534, 6463.192100987377, 6455.903161452488, 6483.351664833479, 6496.480281577557, 6566.212054553484, 6574.408303252731, 6530.902036469552, 6560.737570497317, 6590.487894314349, 6627.237867645283, 6673.766418175341, 6296.6851657417865, 6301.338359472373, 6308.968455157695, 6409.070684750778, 6427.228732552124, 6345.96827015862, 6352.428281454507, 6413.2945376007665, 6422.133012043314, 6443.96778016107, 6237.5009999200865, 6301.275353334242, 6381.3937675920715, 6399.168108146097, 6401.583897046677, 6377.77677781294, 6433.356664333529, 6442.0, 6516.413522782972, 6555.0, 6124.755009799558, 6155.076738489262, 6260.342664020212, 6300.84247893788, 6312.084747711464], "value": 5998.1026408179105, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [768.5350363030367, 770.4876257288903, 781.9296263336299, 801.3068695578323, 817.8568750468669, 43479.78260108699, 43616.34575481362, 43760.0, 44224.778876105614, 44261.114777704424, 38513.0, 38594.228115437676, 38675.22649547007, 38782.41826372607, 38814.8059259704, 6863.7940861774105, 7012.8948065778795, 7015.6141412222305, 7016.228214896358, 7018.122734658168, 6888.380045795878, 6975.441964642841, 6983.441324694012, 6985.615791131486, 6987.091678081868, 6939.861202775942, 7390.593517356543, 7991.041075071, 8008.919910800905, 8017.599120044004, 7919.524828510279, 7972.720954766613, 7973.362131029504, 7977.0, 7984.0, 7607.125180604246, 7841.21587841217, 7880.763577092696, 7905.446618736691, 7932.286094251545, 40239.597604023875, 40643.1871362574, 40723.796381018205, 40749.388759168636, 40772.184556308704, 3510.543629328171, 3536.5756109266795, 3556.1287484566446, 3561.6972557332656, 3568.7680300780366, 32433.675663243303, 32555.51166732501, 32674.6732532674, 32685.50971735426, 32712.182195445304, 4878.926816097762, 4884.242942343943, 4887.682300650446, 4905.166121759309, 4917.950820491785, 180522.0973895122, 185217.0, 185471.0, 187172.0641396798, 233003.0, 52274.73862630662, 52899.0, 52950.0, 52974.205386919224, 53109.2033619496, 54409.1838622421, 54449.45550544523, 54681.72659136679, 55026.97351645698, 55090.449095509335, 16504.0, 16518.0, 16532.173391330387, 16555.0, 16595.253213605418, 13458.057935944586, 13561.728765424636, 13562.660933476742, 13567.932160339333, 13578.0, 14960.326785294688, 15017.624559386102, 15168.0, 15174.24128793556, 15290.617734556725, 5964.403559644001, 6009.188759517409, 6072.483838873657, 6101.725422356005, 6156.138140660311, 980.6763767956558, 989.1246247071393, 1002.9297949143636, 1018.4754851251612, 1033.9224558158169, 22600.886995565244, 22782.31653050411, 23569.292921212393, 26906.32734181661, 28382.432351352858, 1098.2367254757867, 1118.0440723181725, 1124.6850881753123, 1136.1365362324693, 1137.5051852444212, 12315.815262771066, 12592.81110783339, 12598.307093109783, 12645.683857903441, 12681.49274029047, 231086.0, 232938.0, 233241.0, 233680.0, 234134.0, 55760.16359754607, 55899.441005589426, 56007.43992560104, 56221.43778562244, 56299.15551266734, 1446.8697817196503, 1486.524312220101, 1497.286728912282, 1506.5555661080007, 1528.914470725775, 22271.44321391978, 22556.887215563816, 22875.084996600614, 22970.322722304958, 23433.297001089995, 38186.80906595449, 38384.88883111456, 38417.42373864338, 38496.0, 38625.0, 189442.0, 189798.0, 190224.0, 190828.0, 191120.0, 36833.81583092068, 37873.0, 38660.80669596634, 39320.82037538879, 39565.0, 48813.0, 50144.0, 50262.497375025785, 50326.245106322705, 50482.74758626183, 33106.50340244947, 34850.30299393947, 35057.298854023284, 35099.82450087733, 35425.1143721409, 33809.3238135231, 33823.0, 34441.0, 34653.0, 35080.47379289364, 38431.0, 38443.615563844, 38527.229455411296, 38651.22697546089, 39029.6097039026, 33344.66655333416, 33713.66286337105, 33882.0, 34299.82850085833, 34641.13397165091, 24032.918518666353, 24047.95592374668, 24699.461171478968, 24921.376965576004, 25048.499030018935], "value": 17608.99441351778, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.9151127330903, 571.2431028886726, 572.7852055479195, 576.3717547872818, 593.1636392686312, 22404.55190896181, 22581.54836903263, 23413.297601071994, 23414.64878026829, 23455.41361465962, 25934.48131037378, 26330.73669263307, 26465.603015954726, 26478.86760566199, 26537.336566585796, 6502.447291980176, 6655.633940133291, 6657.800265992028, 6675.8331041724105, 6685.298043705414, 6280.811575652738, 6563.868722625544, 6572.112764776742, 6630.900536491957, 6683.198016238058, 6525.086487891699, 6528.347165283458, 6538.150040494753, 6542.574732642387, 6565.507586930976, 6464.191976003, 6483.416492515649, 6491.091247225392, 6523.6738163091895, 6523.902141467882, 6051.4553690168095, 6068.241469816273, 6072.453479186895, 6086.9391306087255, 6097.847553811146, 28569.571456427962, 29299.853500732574, 30004.399912001856, 30261.69738302611, 30297.848510757525, 1954.4234450837037, 1976.5651556657656, 1985.7021446782953, 1991.1836147179731, 1992.1732481020358, 19133.521661958424, 19695.31066412683, 19707.0, 19785.10967006488, 19798.70301945472, 2291.232437133562, 2332.8716920569364, 2343.6718859359703, 2344.109238489363, 2419.830611857171, 132085.0, 138481.61518384787, 139064.0, 139346.0, 139551.0, 14337.713245735027, 15165.601975427002, 15205.239738013277, 15223.0, 15238.619034524225, 22797.544049118926, 23768.88115559411, 23947.401314966915, 23957.52084958291, 23960.0, 9685.467299298607, 9775.755606109762, 9894.812622485348, 9962.900370996342, 10015.599376024877, 9089.091090890857, 9148.268138549034, 9197.310201734897, 9373.671921482852, 9390.34267601275, 8706.303495720455, 8837.867431988525, 8849.64601415949, 8966.775830604287, 8974.461532308082, 2701.4462035283113, 2717.728227177306, 2741.4105967216747, 2777.7222277772466, 2934.090431966097, 951.1202138022302, 959.044334681621, 964.4068897628049, 989.6833013435631, 991.8016396720685, 19356.806431935784, 19442.70835937462, 19584.412467625993, 19646.21415143407, 20385.184592616424, 979.740368802268, 1026.153423425662, 1040.6669865643073, 1046.7540128069897, 1053.847192157133, 10454.268201225994, 10570.894291057144, 10619.415932123808, 11089.390083545482, 11098.889011109946, 451114.0, 452855.0, 457834.0, 463791.0, 470771.0, 118156.0, 120487.0, 121701.39149304197, 123604.38197808953, 126261.0, 1247.827042579972, 1260.5273022616518, 1290.071148772882, 1293.9482420703066, 1294.786360250567, 20324.695129573363, 20970.0, 21585.568288634455, 21612.351629451143, 21664.566708666054, 57024.0, 58193.127103092644, 58261.0, 58372.70813645905, 60135.39864601298, 66735.31617095726, 66963.33036669766, 67886.66056669685, 68506.0, 68895.3110468909, 14978.550643480714, 15169.0, 15249.542513724606, 15360.539183824503, 15392.692146157238, 23818.16636417717, 23981.0, 23991.400214994766, 24532.754672453048, 24538.386540336633, 18640.533986650444, 18694.439166825017, 18725.25098996025, 18995.90502047481, 19012.809871901103, 15583.376664933276, 16850.57873553171, 17565.297388104846, 17618.911905440902, 17933.910330448263, 18632.720509192644, 20166.0, 20278.59442811165, 20349.287774927805, 20377.592448151252, 14776.704465910836, 14869.107853528823, 15086.094834309977, 15182.620434488785, 15188.924055379652, 18578.44264672062, 18931.242750289835, 19016.52458688544, 19236.903815480833, 19241.711374329676], "value": 12118.692332459863, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1377.6073818961595, 1434.1323499282933, 1456.6212784675981, 1462.5027490653179, 1466.5600319904026, 13174.73650526989, 13705.451781928736, 13761.44954201832, 13794.655133621665, 13798.241096739675, 14037.859621403783, 14480.782788258184, 14576.125432474058, 14650.34073466694, 14652.926735366309, 2514.170323793144, 2583.599542070982, 2592.2482480080753, 2593.533164030474, 2594.4681340325283, 2542.9745702542923, 2624.1078033468616, 2627.0542604662305, 2627.605859121128, 2627.81605287629, 2549.4391233928504, 2555.540002799495, 2566.3840678237275, 2568.0626571301527, 2568.5761849294936, 2476.6408870713735, 2528.0014394314235, 2546.732593077728, 2547.694276686791, 2595.8053146014126, 2492.626106084102, 2496.7378425265447, 2519.7858182054547, 2521.13021007752, 2533.936651583707, 13148.6712832179, 13394.866051339459, 13425.530106446227, 13450.0, 13560.728785424237, 7040.366367026941, 7283.854322913565, 7309.597972111532, 7329.523580967273, 7333.0, 4726.550977657117, 4790.880227994293, 4851.393575803025, 4870.099031679115, 4885.877853053702, 1850.1119462658, 1857.2849452960706, 1876.6809642360831, 1884.387574038443, 1916.93290734825, 21474.89262553693, 22238.555228895333, 22456.0, 22467.101315947344, 22479.88760056189, 6473.579217350857, 6570.737170513126, 6699.062131301622, 6739.730410783513, 6769.898451523132, 17528.82471175272, 17628.735568966476, 17652.0, 17690.911545442446, 17693.20380582877, 7256.165540962751, 7481.7755467336065, 7486.85026299471, 7490.250974902466, 7495.250474952461, 5417.783288668488, 6106.267247930188, 6708.362705543063, 6910.170779506391, 6926.307369263033, 5062.924056139161, 5266.947330526646, 5269.420363759983, 5276.208568714646, 5309.150535914235, 1571.3714514194185, 1584.4058478070724, 1609.2597405193508, 1618.5236588020348, 1632.5102469259411, 880.423322723617, 901.8466860633708, 919.1497864475333, 947.8720372749729, 949.6154057606681, 7020.262872398427, 7447.106347238366, 7453.217412171753, 7483.32650061497, 8274.917250827535, 688.4595592459995, 732.7691777090199, 734.4491631276543, 746.1792028768311, 750.2235186581862, 4391.626711729475, 5224.582033437316, 5233.450487698813, 5268.499492548279, 5422.43064478232, 18104.456866294033, 18884.43346699601, 18897.81102188988, 18940.905295473436, 18975.71536426955, 17979.0, 18394.0, 18528.907355463136, 18671.439856804045, 18722.719159212622, 10375.584976601003, 10567.682969510926, 10769.353838769699, 10769.623063192907, 10797.08224800885, 7590.127135379281, 7816.53100813953, 7935.563544005136, 8024.996875390576, 8049.27556519916, 16045.598860028593, 16281.918590406973, 16307.429239976544, 16349.18254087267, 16761.329546818477, 12972.67568310762, 15872.0, 16724.83275167233, 16794.160291985598, 17227.91386043112, 10454.222645951459, 11151.219414640897, 11179.66461006171, 11186.105111591216, 11199.440027998731, 12575.434105465092, 12659.873401266237, 12680.492780288685, 12796.36018199105, 12872.742545148858, 10121.848172277569, 10335.896641033494, 10430.68707938763, 10629.787404252027, 10814.972577605115, 9990.450525221182, 10175.949120254352, 10232.846507302247, 10388.844167337647, 10470.476476176313, 9217.723468295962, 9267.629294828132, 9271.211946984582, 9400.670976515788, 9446.338756286994, 6788.796336109925, 6821.897671534832, 7085.929140708527, 7209.35115839577, 7243.022192004223, 7250.854982900207, 7267.200607933229, 7273.854522909406, 7275.417966562556, 7418.369438597564], "value": 6233.038355135402, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [447.0, 461.4485689600928, 484.665580749283, 487.9971658242313, 492.4066499867658, 6074.635521868691, 6093.750781089877, 6107.450329470346, 6129.325774164844, 6187.319394866567, 5842.357340692531, 5908.940910590893, 5933.821985340436, 5984.251968503937, 6011.338752737195, 4883.682560633565, 4886.706797592147, 4895.290182923474, 4912.582430493412, 4931.211006239003, 4768.403949506312, 4895.265710143472, 4918.852434426973, 4930.580900623451, 4954.900901981958, 4842.806287748486, 4851.708897466146, 4860.951390486085, 4864.635152363569, 4871.468185565454, 4855.975720121394, 4867.2212446008825, 4891.779869905863, 4893.6329775266995, 4899.58353539946, 4325.480942286914, 4338.0, 4340.52254252032, 4364.170807546556, 4364.756044527327, 5844.853878653025, 5853.414658534155, 5882.941170588282, 5915.201447804534, 5989.970050149721, 5499.807506737285, 5559.221708960748, 5589.245451864028, 5598.608097433141, 5642.181883626892, 6356.745730170787, 6389.817883691532, 6412.551121421502, 6446.743639726105, 6476.481881449473, 4686.929696054562, 4728.574428301435, 4751.762411879392, 4776.020915712271, 4798.424189097295, 6801.523893327469, 6850.4862135340045, 6869.278725733826, 6883.208431030395, 6896.724131034753, 4910.48439913811, 4943.456219815817, 4950.985048065138, 4962.206047032458, 4962.826301079445, 4878.268259761065, 4953.455119936804, 4963.205887058053, 5002.473750755845, 5027.874303142451, 5528.530074943595, 5576.163575463713, 5624.55003599711, 5626.324841019104, 5649.406812284651, 6428.4857211423905, 6441.066045423388, 6445.2265728112925, 6446.903296450557, 6462.4183823456115, 1643.5644554193148, 1679.706051440993, 1717.8625709943174, 1863.7856646485827, 1872.7190921361905, 1415.1296952374216, 1417.9574612761633, 1430.1204759073096, 1431.9642008949859, 1446.5877224990827, 5493.670379777226, 5635.0, 5644.407337229614, 5646.350669672958, 5665.745041473144, 6347.650879201688, 6432.719313150327, 6473.385028422293, 6549.443297319781, 6629.7679581214425, 5613.214150018919, 5615.298087739033, 5621.128725047624, 5632.408597097327, 5655.632383895034, 3483.965160348364, 3489.965100348964, 3504.421770407905, 3537.398642230827, 3537.814832031247, 6359.618422894641, 6362.745490180433, 6385.48916086712, 6443.387878151568, 6452.35476452351, 6723.924172132435, 6762.898556521656, 6781.287964763727, 6804.149481314836, 6833.829154271183, 6418.839529011812, 6426.582272152295, 6456.0961465394885, 6471.352864713585, 6504.38208370204, 6568.916128838688, 6629.337066293332, 6645.534812563074, 6653.502961833548, 6671.166104236971, 6495.870082598416, 6550.508711846535, 6571.967140164268, 6582.868342633024, 6603.641596546257, 6353.633968696752, 6435.22777266731, 6439.293587199302, 6455.741770329134, 6496.350364963466, 4813.0, 4876.780544875418, 4896.951030489649, 4908.975455122844, 4912.680675756064, 6307.400796924285, 6368.617882927039, 6565.146530950946, 6599.1953419797355, 6611.537192396486, 6259.749610015549, 6354.3963323484195, 6365.267994180728, 6390.808275751735, 6432.581882177644, 6459.61242325462, 6460.870782584416, 6467.805965821033, 6473.514486413444, 6473.838154046187, 6319.210098737658, 6349.650629267201, 6369.331220221995, 6392.3927226913365, 6439.484841212598, 6409.353218916249, 6446.226452825504, 6467.15926929515, 6468.2859042352875, 6469.061986011908, 6228.532860035425, 6263.841189379979, 6267.185265915584, 6272.874542509033, 6292.024736165901], "value": 4977.664407921791, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [909.1136142261296, 929.2333824594709, 941.1529623338989, 950.710033439801, 950.9334346595739, 17386.82613173868, 18708.625827483444, 18717.157727902242, 18729.531761705948, 18801.623967520674, 17783.199756010978, 19140.712889306673, 19145.32991345303, 19200.327988520403, 19214.807851921476, 1020.8979102089787, 1038.7662775875406, 1041.3023274406166, 1047.9842802357932, 1048.4390850894772, 983.4640121133999, 1065.690949624608, 1069.2408390043079, 1074.9946250268777, 1076.8277075667895, 1098.906592939601, 1104.4367372639972, 1105.7622611138604, 1106.7454485468347, 1107.640016994476, 1096.8245080787035, 1098.3739268616891, 1100.2023532938636, 1101.581399068353, 1102.4653043274006, 806.4475834053692, 806.891069705588, 811.342812322021, 812.2080971053235, 812.4191203289618, 19474.123664434992, 19853.205871765113, 20046.09792559338, 20100.396988090233, 20226.19095236189, 20150.798492015187, 20645.380638580868, 20683.793162068338, 21061.47346316339, 21087.261945831822, 15797.92101039499, 16239.594010149722, 16314.428994985119, 16374.181290935405, 16460.259288331934, 3602.0274525877867, 3619.2218672985437, 3621.474886141521, 3623.076115590534, 3624.4925710400566, 121446.71212741845, 125456.37271813674, 128746.0, 129442.3527882364, 130364.0, 15351.92324038395, 16060.116693581731, 16203.0, 16445.58886027859, 16454.75317870233, 31039.0, 31127.066188014396, 31236.531452028237, 31771.52342714861, 31899.52150717741, 8416.621252043673, 8649.394542382099, 8666.956665216634, 8689.217970382695, 8696.478211307342, 4052.0, 4077.4699289092227, 4109.0549173690215, 4130.91738165235, 4133.090720041586, 4918.483559226302, 5132.101882170605, 5133.614978876599, 5135.15269980449, 5138.229265610188, 996.2179688944144, 1001.9749506262402, 1010.5149528226492, 1015.081351377005, 1020.7346090016649, 678.494521581425, 683.6650041479639, 686.8385929306609, 714.310690183975, 722.5917356693451, 12045.21706089119, 12127.514899404101, 13088.149270297401, 13862.93068534651, 14056.0, 702.5257950883133, 708.2917082917083, 712.9572225666477, 715.7602203261862, 723.5730918757853, 5259.815906443333, 5508.366537848118, 5628.352739434936, 5653.802116925888, 5678.375378708339, 100231.36002718397, 100669.9799006031, 102010.48994754978, 104173.47913260385, 104248.0, 86289.0, 89506.55246723855, 92704.53647731718, 94707.0, 95756.0, 73683.0, 75553.24446755572, 79591.0, 79839.60080199562, 79848.0, 10678.786424271315, 10795.40625265618, 11026.669199924016, 11264.774704506028, 11286.0, 33167.66832331646, 35125.0, 35775.82112089423, 36075.45886811752, 37027.81486092552, 42366.5763342375, 44550.0, 44744.328835068154, 44770.77614611906, 45353.77323113364, 16010.19949002522, 18845.0, 19465.221391144194, 19590.236878680986, 19716.704249436556, 20499.59000820005, 20817.791822081585, 21473.570528589655, 21535.353939381843, 22272.10911563584, 18984.671073024754, 19139.0, 19339.0, 19350.903245484245, 19510.8048919509, 17497.21262543163, 17543.82456175473, 17604.119794010505, 17642.82357176412, 19326.130324135167, 17729.37947171843, 17936.192871321084, 18267.54331141732, 18312.26750929948, 18517.722234166227, 12611.369431528203, 13581.86418135806, 13796.379162937492, 13840.792388113985, 13846.515371961934, 14084.01411901157, 15156.317965691349, 15246.466373676869, 15384.923075384551, 15423.305951232445], "value": 9008.213621739724, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1537.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 103.0, 109.0, 110.0, 111.0, 110.0, 102.0, 111.0, 112.0], "value": 107.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 120.0, 142.0, 187.0, 119.0, 149.0, 149.0, 123.0, 177.0, 122.0], "value": 144.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 164.0, 165.0, 166.0, 164.0, 167.0, 165.0, 169.0, 165.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 107.0, 77.0, 77.0, 75.0, 94.0, 100.0, 81.0], "value": 83.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 139.0, 80.0, 79.0, 80.0, 139.0, 83.0, 82.0, 142.0], "value": 98.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 116.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 151.0, 151.0, 151.0, 150.0, 151.0, 151.0, 151.0, 150.0, 150.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 60.0, 55.0, 55.0, 55.0, 54.0, 61.0, 55.0, 55.0, 56.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 54.0, 54.0, 55.0, 54.0, 54.0, 55.0, 55.0], "value": 54.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 86.0, 78.0, 79.0, 79.0, 77.0, 77.0, 88.0, 85.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 131.0, 126.0, 129.0, 130.0, 125.0, 138.0, 129.0, 127.0, 169.0], "value": 133.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 179.0, 180.0, 194.0, 178.0, 186.0, 180.0, 190.0, 180.0, 188.0], "value": 183.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 69.0, 74.0, 71.0, 71.0, 68.0, 68.0, 70.0, 68.0], "value": 69.8, "unit": "score"}]}]} 10:22:15 INFO - Return code: 0 10:22:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:22:15 INFO - # TBPL SUCCESS # 10:22:15 INFO - Running post-action listener: _package_coverage_data 10:22:15 INFO - Running post-action listener: _resource_record_post_action 10:22:15 INFO - [mozharness: 2017-07-19 17:22:15.899476Z] Finished run-tests step (success) 10:22:15 INFO - Running post-run listener: _resource_record_post_run 10:22:15 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 437018624; Read time: 12; Write time: 327776 10:22:15 INFO - TinderboxPrint: CPU usage
13.1% 10:22:15 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:22:15 INFO - TinderboxPrint: I/O write bytes / time
437,018,624 / 327,776 10:22:15 INFO - TinderboxPrint: CPU idle
8,269.7 (86.9%) 10:22:15 INFO - TinderboxPrint: CPU user
1,199.2 (12.6%) 10:22:15 INFO - TinderboxPrint: Swap in / out
0 / 0 10:22:15 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107552768; Read time: 0; Write time: 82536 10:22:15 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 10:22:15 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 329465856; Read time: 0; Write time: 245240 10:22:16 INFO - Running post-run listener: _upload_blobber_files 10:22:16 INFO - Blob upload gear active. 10:22:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:22:16 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 10:22:16 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:22:16 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:22:16 INFO - (blobuploader) - INFO - Open directory for files ... 10:22:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:22:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:22:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:17 INFO - (blobuploader) - INFO - Done attempting. 10:22:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:22:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:22:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:18 INFO - (blobuploader) - INFO - Done attempting. 10:22:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:22:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:22:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:19 INFO - (blobuploader) - INFO - Done attempting. 10:22:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:22:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:22:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:22 INFO - (blobuploader) - INFO - Done attempting. 10:22:22 INFO - (blobuploader) - INFO - Iteration through files over. 10:22:22 INFO - Return code: 0 10:22:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:22:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:22:22 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/817746b9795a4b2eebeaba957462d92cde2cc50c01f8907f6e9e4971836276042a2dfd230b89bab3d1ba39fbfd6cc0c8481edc63a1d94923b474975ca6213675", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ed672c8d6cba2d673bb4dd4c648091ad42b0adf3af0e32cdfcc52b61f2ae861d50e5a50df2653266a3306533b1a41c13de2ca93ccc2341f7a48fdcc774516248", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ae7892c6be025a75a0fbce7f69e8d8a0381753ad2f7fe970fb41308b8980d79b5024cbb753b6a93c9359a2aeb41557e67558c54d973fb43e485c8e560726d9f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/27fba2e55ba4ad514e4b4f0d80fd8fac0e36dd01f8a1a66a0ab264be6c224240a000262962c52f1010242eb55d39c9f7b4879ffff45009a82b4a46701d12761c"} 10:22:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:22:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:22:22 INFO - Contents: 10:22:22 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/817746b9795a4b2eebeaba957462d92cde2cc50c01f8907f6e9e4971836276042a2dfd230b89bab3d1ba39fbfd6cc0c8481edc63a1d94923b474975ca6213675", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ed672c8d6cba2d673bb4dd4c648091ad42b0adf3af0e32cdfcc52b61f2ae861d50e5a50df2653266a3306533b1a41c13de2ca93ccc2341f7a48fdcc774516248", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ae7892c6be025a75a0fbce7f69e8d8a0381753ad2f7fe970fb41308b8980d79b5024cbb753b6a93c9359a2aeb41557e67558c54d973fb43e485c8e560726d9f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/27fba2e55ba4ad514e4b4f0d80fd8fac0e36dd01f8a1a66a0ab264be6c224240a000262962c52f1010242eb55d39c9f7b4879ffff45009a82b4a46701d12761c"} 10:22:22 INFO - Running post-run listener: copy_logs_to_upload_dir 10:22:22 INFO - Copying logs to upload dir... 10:22:22 INFO - mkdir: /builds/slave/test/build/upload/logs 10:22:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.070292 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-07-19 10:22:21.530821) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-19 10:22:21.534684) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1500483085.397713-196695689 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-Non-PGO/sha512/817746b9795a4b2eebeaba957462d92cde2cc50c01f8907f6e9e4971836276042a2dfd230b89bab3d1ba39fbfd6cc0c8481edc63a1d94923b474975ca6213675", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ed672c8d6cba2d673bb4dd4c648091ad42b0adf3af0e32cdfcc52b61f2ae861d50e5a50df2653266a3306533b1a41c13de2ca93ccc2341f7a48fdcc774516248", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ae7892c6be025a75a0fbce7f69e8d8a0381753ad2f7fe970fb41308b8980d79b5024cbb753b6a93c9359a2aeb41557e67558c54d973fb43e485c8e560726d9f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/27fba2e55ba4ad514e4b4f0d80fd8fac0e36dd01f8a1a66a0ab264be6c224240a000262962c52f1010242eb55d39c9f7b4879ffff45009a82b4a46701d12761c"} build_url:https://queue.taskcluster.net/v1/task/VQi_Zdf1Sr2fiUb0MKC7jg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011477 build_url: 'https://queue.taskcluster.net/v1/task/VQi_Zdf1Sr2fiUb0MKC7jg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/817746b9795a4b2eebeaba957462d92cde2cc50c01f8907f6e9e4971836276042a2dfd230b89bab3d1ba39fbfd6cc0c8481edc63a1d94923b474975ca6213675", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ed672c8d6cba2d673bb4dd4c648091ad42b0adf3af0e32cdfcc52b61f2ae861d50e5a50df2653266a3306533b1a41c13de2ca93ccc2341f7a48fdcc774516248", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ae7892c6be025a75a0fbce7f69e8d8a0381753ad2f7fe970fb41308b8980d79b5024cbb753b6a93c9359a2aeb41557e67558c54d973fb43e485c8e560726d9f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/27fba2e55ba4ad514e4b4f0d80fd8fac0e36dd01f8a1a66a0ab264be6c224240a000262962c52f1010242eb55d39c9f7b4879ffff45009a82b4a46701d12761c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-19 10:22:21.563059) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-19 10:22:21.563706) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1500483085.397713-196695689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004523 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-19 10:22:21.649742) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-19 10:22:21.650474) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-19 10:22:21.651126) ========= ========= Total master_lag: 0.17 =========