builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-007 starttime: 1498219689.26 results: success (0) revision: 2f10d697c307a09a286faa1f11831644c40f778d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-23 05:08:09.263724) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-23 05:08:09.264208) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-23 05:08:09.264503) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-23 05:08:09.279893) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-23 05:08:09.280241) ========= 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=923d835db2ba3686ebe126b700000192-1498219689.209042-1251615511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-23 05:08:09-- 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% 107M=0s 2017-06-23 05:08:09 (107 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130992 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-23 05:08:09.424065) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-23 05:08:09.424380) ========= 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=923d835db2ba3686ebe126b700000192-1498219689.209042-1251615511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016805 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-23 05:08:09.474373) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-23 05:08:09.474729) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2f10d697c307a09a286faa1f11831644c40f778d --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 2f10d697c307a09a286faa1f11831644c40f778d --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=923d835db2ba3686ebe126b700000192-1498219689.209042-1251615511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-23 05:08:09,940 truncating revision to first 12 chars 2017-06-23 05:08:09,940 Setting DEBUG logging. 2017-06-23 05:08:09,940 attempt 1/10 2017-06-23 05:08:09,940 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2f10d697c307?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-23 05:08:10,407 unpacking tar archive at: mozilla-central-2f10d697c307/testing/mozharness/ program finished with exit code 0 elapsedTime=0.791511 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-23 05:08:10.278382) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-23 05:08:10.278727) ========= script_repo_revision: 2f10d697c307a09a286faa1f11831644c40f778d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-23 05:08:10.279168) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-23 05:08:10.279482) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-23 05:08:10.287676) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-06-23 05:08:10.288045) ========= /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=923d835db2ba3686ebe126b700000192-1498219689.209042-1251615511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:08:10 INFO - MultiFileLogger online at 20170623 05:08:10 in /builds/slave/test 05:08:10 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 05:08:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:08:10 INFO - {'append_to_log': False, 05:08:10 INFO - 'base_work_dir': '/builds/slave/test', 05:08:10 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:08:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:08:10 INFO - 'branch': 'Firefox-Non-PGO', 05:08:10 INFO - 'buildbot_json_path': 'buildprops.json', 05:08:10 INFO - 'config_files': ('talos/linux_config.py',), 05:08:10 INFO - 'default_actions': ('clobber', 05:08:10 INFO - 'read-buildbot-config', 05:08:10 INFO - 'download-and-extract', 05:08:10 INFO - 'populate-webroot', 05:08:10 INFO - 'create-virtualenv', 05:08:10 INFO - 'install', 05:08:10 INFO - 'setup-mitmproxy', 05:08:10 INFO - 'run-tests'), 05:08:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:08:10 INFO - 'download_minidump_stackwalk': True, 05:08:10 INFO - 'download_symbols': 'ondemand', 05:08:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:08:10 INFO - 'tooltool.py': '/tools/tooltool.py', 05:08:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:08:10 INFO - '/tools/misc-python/virtualenv.py')}, 05:08:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:08:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:08:10 INFO - 'gecko_profile': False, 05:08:10 INFO - 'gecko_profile_interval': 0, 05:08:10 INFO - 'installer_path': 'installer.exe', 05:08:10 INFO - 'log_level': 'info', 05:08:10 INFO - 'log_name': 'talos', 05:08:10 INFO - 'log_to_console': True, 05:08:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:08:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:08:10 INFO - 'opt_config_files': (), 05:08:10 INFO - 'pip_index': False, 05:08:10 INFO - 'suite': 'dromaeojs-e10s', 05:08:10 INFO - 'system_bits': '32', 05:08:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:08:10 INFO - 'title': 'talos-linux64-ix-007', 05:08:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:08:10 INFO - 'use_talos_json': True, 05:08:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:08:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:08:10 INFO - 'work_dir': 'build'} 05:08:10 INFO - [mozharness: 2017-06-23 12:08:10.856354Z] Running clobber step. 05:08:10 INFO - Running pre-action listener: _resource_record_pre_action 05:08:10 INFO - Running main action method: clobber 05:08:10 INFO - rmtree: /builds/slave/test/build 05:08:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:08:11 INFO - Running post-action listener: _resource_record_post_action 05:08:11 INFO - [mozharness: 2017-06-23 12:08:11.891006Z] Finished clobber step (success) 05:08:11 INFO - [mozharness: 2017-06-23 12:08:11.891105Z] Running read-buildbot-config step. 05:08:11 INFO - Running pre-action listener: _resource_record_pre_action 05:08:11 INFO - Running main action method: read_buildbot_config 05:08:11 INFO - Using buildbot properties: 05:08:11 INFO - { 05:08:11 INFO - "project": "", 05:08:11 INFO - "product": "firefox", 05:08:11 INFO - "who": "cbook@mozilla.com", 05:08:11 INFO - "installer_path": "public/build/target.tar.bz2", 05:08:11 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:08:11 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:08:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 05:08:11 INFO - "stage_platform": "linux64", 05:08:11 INFO - "basedir": "/builds/slave/test", 05:08:11 INFO - "buildnumber": 976, 05:08:11 INFO - "platform": "ubuntu64_hw", 05:08:11 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:08:11 INFO - "slavebuilddir": "test", 05:08:11 INFO - "taskId": "f7VBG6SiQBWLSNT7Es6r9w", 05:08:11 INFO - "branch": "mozilla-central", 05:08:11 INFO - "script_repo_revision": "production", 05:08:11 INFO - "revision": "2f10d697c307a09a286faa1f11831644c40f778d", 05:08:11 INFO - "slavename": "talos-linux64-ix-007", 05:08:11 INFO - "repo_path": "mozilla-central" 05:08:11 INFO - } 05:08:11 INFO - Finding installer, test and symbols from parent task. 05:08:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f7VBG6SiQBWLSNT7Es6r9w'}, attempt #1 05:08:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f7VBG6SiQBWLSNT7Es6r9w'}, attempt #1 05:08:12 INFO - Task dependencies: MTnXcDzoQ9e4HWmOWIKQqw 05:08:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MTnXcDzoQ9e4HWmOWIKQqw'}, attempt #1 05:08:13 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/MTnXcDzoQ9e4HWmOWIKQqw/artifacts/public/build/target.tar.bz2 05:08:13 INFO - Set test_url: https://queue.taskcluster.net/v1/task/MTnXcDzoQ9e4HWmOWIKQqw/artifacts/public/build/test_packages.json 05:08:13 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/MTnXcDzoQ9e4HWmOWIKQqw/artifacts/public/build/target.crashreporter-symbols.zip 05:08:13 INFO - Running post-action listener: _resource_record_post_action 05:08:13 INFO - [mozharness: 2017-06-23 12:08:13.250026Z] Finished read-buildbot-config step (success) 05:08:13 INFO - [mozharness: 2017-06-23 12:08:13.250251Z] Running download-and-extract step. 05:08:13 INFO - Running pre-action listener: _resource_record_pre_action 05:08:13 INFO - Running main action method: download_and_extract 05:08:13 INFO - mkdir: /builds/slave/test/build/tests 05:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:13 INFO - trying https://queue.taskcluster.net/v1/task/MTnXcDzoQ9e4HWmOWIKQqw/artifacts/public/build/target.test_packages.json 05:08:13 INFO - Downloading https://queue.taskcluster.net/v1/task/MTnXcDzoQ9e4HWmOWIKQqw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:08:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MTnXcDzoQ9e4HWmOWIKQqw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:08:13 INFO - Downloaded 989 bytes. 05:08:13 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:08:13 INFO - Using the following test package requirements: 05:08:13 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:08:13 INFO - u'common': [u'target.common.tests.zip'], 05:08:13 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:08:13 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:08:13 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:08:13 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:08:13 INFO - u'mozbase': [u'target.common.tests.zip'], 05:08:13 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:08:13 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:08:13 INFO - u'web-platform': [u'target.common.tests.zip', 05:08:13 INFO - u'target.web-platform.tests.tar.gz'], 05:08:13 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:08:13 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:08:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MTnXcDzoQ9e4HWmOWIKQqw/artifacts/public/build/target.common.tests.zip 05:08:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MTnXcDzoQ9e4HWmOWIKQqw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:08:13 INFO - Fetch https://queue.taskcluster.net/v1/task/MTnXcDzoQ9e4HWmOWIKQqw/artifacts/public/build/target.common.tests.zip into memory 05:08:14 INFO - Content-Length response header: 67757634 05:08:14 INFO - Bytes received: 67757634 05:08:26 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:08:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MTnXcDzoQ9e4HWmOWIKQqw/artifacts/public/build/target.common.tests.zip 05:08:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MTnXcDzoQ9e4HWmOWIKQqw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:08:26 INFO - Fetch https://queue.taskcluster.net/v1/task/MTnXcDzoQ9e4HWmOWIKQqw/artifacts/public/build/target.common.tests.zip into memory 05:08:27 INFO - Content-Length response header: 67757634 05:08:27 INFO - Bytes received: 67757634 05:08:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MTnXcDzoQ9e4HWmOWIKQqw/artifacts/public/build/target.talos.tests.zip 05:08:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MTnXcDzoQ9e4HWmOWIKQqw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:08:39 INFO - Fetch https://queue.taskcluster.net/v1/task/MTnXcDzoQ9e4HWmOWIKQqw/artifacts/public/build/target.talos.tests.zip into memory 05:08:40 INFO - Content-Length response header: 14441306 05:08:40 INFO - Bytes received: 14441306 05:08: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')]} 05:08:40 INFO - trying https://queue.taskcluster.net/v1/task/MTnXcDzoQ9e4HWmOWIKQqw/artifacts/public/build/target.tar.bz2 05:08:40 INFO - Downloading https://queue.taskcluster.net/v1/task/MTnXcDzoQ9e4HWmOWIKQqw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:08:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MTnXcDzoQ9e4HWmOWIKQqw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:08:41 INFO - Downloaded 61720470 bytes. 05:08:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MTnXcDzoQ9e4HWmOWIKQqw/artifacts/public/build/target.tar.bz2 05:08:41 INFO - mkdir: /builds/slave/test/properties 05:08:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:08:41 INFO - Writing to file /builds/slave/test/properties/build_url 05:08:41 INFO - Contents: 05:08:41 INFO - build_url:https://queue.taskcluster.net/v1/task/MTnXcDzoQ9e4HWmOWIKQqw/artifacts/public/build/target.tar.bz2 05:08:41 INFO - Running post-action listener: _resource_record_post_action 05:08:41 INFO - Running post-action listener: set_extra_try_arguments 05:08:41 INFO - [mozharness: 2017-06-23 12:08:41.577549Z] Finished download-and-extract step (success) 05:08:41 INFO - [mozharness: 2017-06-23 12:08:41.577646Z] Running populate-webroot step. 05:08:41 INFO - Running pre-action listener: _resource_record_pre_action 05:08:41 INFO - Running main action method: populate_webroot 05:08:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:08:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:08:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:08:41 INFO - '--tppagecycles', 05:08:41 INFO - '7'], 05:08:41 INFO - 'tests': ['tsvgm']}}, 05:08:41 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:08:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:08:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:08:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:08:41 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:08:41 INFO - 'talos_options': ['--disable-e10s'], 05:08:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:08:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:08:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:08:41 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:08:41 INFO - 'talos_options': ['--disable-e10s'], 05:08:41 INFO - 'tests': ['damp', 'tps']}, 05:08:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:08:41 INFO - 'tests': ['damp', 'tps']}, 05:08:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:08:41 INFO - 'tests': ['dromaeo_dom']}, 05:08:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:08:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:08:41 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:08:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:08:41 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:08:41 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:08:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:08:41 INFO - 'tests': ['a11yr', 05:08:41 INFO - 'ts_paint', 05:08:41 INFO - 'tpaint', 05:08:41 INFO - 'sessionrestore', 05:08:41 INFO - 'sessionrestore_no_auto_restore', 05:08:41 INFO - 'tabpaint']}, 05:08:41 INFO - 'other-e10s': {'tests': ['a11yr', 05:08:41 INFO - 'ts_paint', 05:08:41 INFO - 'tpaint', 05:08:41 INFO - 'sessionrestore', 05:08:41 INFO - 'sessionrestore_no_auto_restore', 05:08:41 INFO - 'tabpaint']}, 05:08:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:08:41 INFO - 'ts_paint', 05:08:41 INFO - 'tpaint', 05:08:41 INFO - 'sessionrestore', 05:08:41 INFO - 'sessionrestore_no_auto_restore', 05:08:41 INFO - 'tabpaint']}, 05:08:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:08:41 INFO - 'ts_paint', 05:08:41 INFO - 'tpaint', 05:08:41 INFO - 'sessionrestore', 05:08:41 INFO - 'sessionrestore_no_auto_restore', 05:08:41 INFO - 'tabpaint']}, 05:08:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:08:41 INFO - 'tests': ['a11yr', 05:08:41 INFO - 'ts_paint', 05:08:41 INFO - 'tpaint', 05:08:41 INFO - 'sessionrestore', 05:08:41 INFO - 'sessionrestore_no_auto_restore', 05:08:41 INFO - 'tabpaint']}, 05:08:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:08:41 INFO - 'tests': ['a11yr', 05:08:41 INFO - 'ts_paint', 05:08:41 INFO - 'tpaint', 05:08:41 INFO - 'sessionrestore', 05:08:41 INFO - 'sessionrestore_no_auto_restore', 05:08:41 INFO - 'tabpaint']}, 05:08:41 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 05:08:41 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 05:08:41 INFO - 'bloom_basic_ref']}, 05:08:41 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:08:41 INFO - 'talos_options': ['--mitmproxy', 05:08:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:08:41 INFO - '--firstNonBlankPaint'], 05:08:41 INFO - 'tests': ['quantum_pageload_google', 05:08:41 INFO - 'quantum_pageload_youtube', 05:08:41 INFO - 'quantum_pageload_amazon', 05:08:41 INFO - 'quantum_pageload_facebook']}, 05:08:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:08:41 INFO - 'tests': ['tsvgx', 05:08:41 INFO - 'tsvgr_opacity', 05:08:41 INFO - 'tart', 05:08:41 INFO - 'tscrollx', 05:08:41 INFO - 'cart', 05:08:41 INFO - 'tsvg_static']}, 05:08:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:08:41 INFO - 'tsvgr_opacity', 05:08:41 INFO - 'tart', 05:08:41 INFO - 'tscrollx', 05:08:41 INFO - 'cart', 05:08:41 INFO - 'tsvg_static']}, 05:08:41 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:08:41 INFO - 'talos_options': ['--disable-e10s'], 05:08:41 INFO - 'tests': ['tp5o']}, 05:08:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:08:41 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:08:41 INFO - 'talos_options': ['--disable-e10s', 05:08:41 INFO - '--xperf_path', 05:08:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:08:41 INFO - 'tests': ['tp5n']}, 05:08:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:08:41 INFO - 'talos_options': ['--xperf_path', 05:08:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:08:41 INFO - 'tests': ['tp5n']}}, 05:08:41 INFO - 'talos.zip': {'path': '', 05:08:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:08:41 INFO - Running post-action listener: _resource_record_post_action 05:08:41 INFO - [mozharness: 2017-06-23 12:08:41.592580Z] Finished populate-webroot step (success) 05:08:41 INFO - [mozharness: 2017-06-23 12:08:41.592670Z] Running create-virtualenv step. 05:08:41 INFO - Running pre-action listener: _resource_record_pre_action 05:08:41 INFO - Running main action method: create_virtualenv 05:08:41 INFO - Creating virtualenv /builds/slave/test/build/venv 05:08:41 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 05:08:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:08:41 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:08:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:08:41 INFO - Using real prefix '/usr' 05:08:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:08:42 INFO - Installing distribute.............................................................................................................................................................................................done. 05:08:44 INFO - Installing pip.................done. 05:08:44 INFO - Return code: 0 05:08:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:08:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:08:44 INFO - Reading from file tmpfile_stdout 05:08:44 INFO - Output received: 05:08:44 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) 05:08:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:44 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 0x108c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1266a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1408140>, '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 0x1408a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1408ed0>, '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': '923d835db2ba3686ebe126b700000192-1498219689.209042-1251615511', '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 05:08:44 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 05:08:44 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 05:08:44 INFO - Using env: {'DISPLAY': ':0', 05:08:44 INFO - 'HOME': '/home/cltbld', 05:08:44 INFO - 'LANG': 'en_US.UTF-8', 05:08:44 INFO - 'LANGUAGE': 'en_US:en', 05:08:44 INFO - 'LOGNAME': 'cltbld', 05:08:44 INFO - 'MAIL': '/var/mail/cltbld', 05:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:44 INFO - 'MOZ_NO_REMOTE': '1', 05:08:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:44 INFO - 'NO_EM_RESTART': '1', 05:08:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:44 INFO - 'PWD': '/builds/slave/test', 05:08:44 INFO - 'SHELL': '/bin/bash', 05:08:44 INFO - 'SHLVL': '1', 05:08:44 INFO - 'TERM': 'linux', 05:08:44 INFO - 'TMOUT': '86400', 05:08:44 INFO - 'USER': 'cltbld', 05:08:44 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1498219689.209042-1251615511', 05:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:44 INFO - '_': '/tools/buildbot/bin/python'} 05:08:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:44 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 05:08:44 INFO - Cleaning up... 05:08:44 INFO - Return code: 0 05:08:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:44 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 0x108c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1266a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1408140>, '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 0x1408a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1408ed0>, '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': '923d835db2ba3686ebe126b700000192-1498219689.209042-1251615511', '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 05:08:44 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 05:08:44 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 05:08:44 INFO - Using env: {'DISPLAY': ':0', 05:08:44 INFO - 'HOME': '/home/cltbld', 05:08:44 INFO - 'LANG': 'en_US.UTF-8', 05:08:44 INFO - 'LANGUAGE': 'en_US:en', 05:08:44 INFO - 'LOGNAME': 'cltbld', 05:08:44 INFO - 'MAIL': '/var/mail/cltbld', 05:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:44 INFO - 'MOZ_NO_REMOTE': '1', 05:08:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:44 INFO - 'NO_EM_RESTART': '1', 05:08:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:44 INFO - 'PWD': '/builds/slave/test', 05:08:44 INFO - 'SHELL': '/bin/bash', 05:08:44 INFO - 'SHLVL': '1', 05:08:44 INFO - 'TERM': 'linux', 05:08:44 INFO - 'TMOUT': '86400', 05:08:44 INFO - 'USER': 'cltbld', 05:08:44 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1498219689.209042-1251615511', 05:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:44 INFO - '_': '/tools/buildbot/bin/python'} 05:08:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:44 INFO - Downloading/unpacking psutil>=3.1.1 05:08:44 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 05:08:44 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 05:08:44 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 05:08:44 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 05:08:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:08:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:08:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:08:46 INFO - Installing collected packages: psutil 05:08:46 INFO - Running setup.py install for psutil 05:08:46 INFO - building 'psutil._psutil_linux' extension 05:08:46 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 05:08:46 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 05:08:46 INFO - building 'psutil._psutil_posix' extension 05:08:46 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 05:08:46 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 05:08:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:08:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:08:46 INFO - Successfully installed psutil 05:08:46 INFO - Cleaning up... 05:08:46 INFO - Return code: 0 05:08:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:08:46 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')]} 05:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:46 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')]} 05:08:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:46 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 0x108c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1266a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1408140>, '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 0x1408a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1408ed0>, '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': '923d835db2ba3686ebe126b700000192-1498219689.209042-1251615511', '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 05:08:46 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 05:08:46 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 05:08:46 INFO - Using env: {'DISPLAY': ':0', 05:08:46 INFO - 'HOME': '/home/cltbld', 05:08:46 INFO - 'LANG': 'en_US.UTF-8', 05:08:46 INFO - 'LANGUAGE': 'en_US:en', 05:08:46 INFO - 'LOGNAME': 'cltbld', 05:08:46 INFO - 'MAIL': '/var/mail/cltbld', 05:08:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:46 INFO - 'MOZ_NO_REMOTE': '1', 05:08:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:46 INFO - 'NO_EM_RESTART': '1', 05:08:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:46 INFO - 'PWD': '/builds/slave/test', 05:08:46 INFO - 'SHELL': '/bin/bash', 05:08:46 INFO - 'SHLVL': '1', 05:08:46 INFO - 'TERM': 'linux', 05:08:46 INFO - 'TMOUT': '86400', 05:08:46 INFO - 'USER': 'cltbld', 05:08:46 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1498219689.209042-1251615511', 05:08:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:46 INFO - '_': '/tools/buildbot/bin/python'} 05:08:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:08:46 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 05:08:46 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 05:08:46 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 05:08:46 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 05:08:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:08:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:08:47 INFO - Installing collected packages: mozsystemmonitor 05:08:47 INFO - Running setup.py install for mozsystemmonitor 05:08:48 INFO - Successfully installed mozsystemmonitor 05:08:48 INFO - Cleaning up... 05:08:48 INFO - Return code: 0 05:08:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:08:48 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')]} 05:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:48 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')]} 05:08:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:48 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 0x108c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1266a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1408140>, '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 0x1408a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1408ed0>, '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': '923d835db2ba3686ebe126b700000192-1498219689.209042-1251615511', '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 05:08:48 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 05:08:48 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 05:08:48 INFO - Using env: {'DISPLAY': ':0', 05:08:48 INFO - 'HOME': '/home/cltbld', 05:08:48 INFO - 'LANG': 'en_US.UTF-8', 05:08:48 INFO - 'LANGUAGE': 'en_US:en', 05:08:48 INFO - 'LOGNAME': 'cltbld', 05:08:48 INFO - 'MAIL': '/var/mail/cltbld', 05:08:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:48 INFO - 'MOZ_NO_REMOTE': '1', 05:08:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:48 INFO - 'NO_EM_RESTART': '1', 05:08:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:48 INFO - 'PWD': '/builds/slave/test', 05:08:48 INFO - 'SHELL': '/bin/bash', 05:08:48 INFO - 'SHLVL': '1', 05:08:48 INFO - 'TERM': 'linux', 05:08:48 INFO - 'TMOUT': '86400', 05:08:48 INFO - 'USER': 'cltbld', 05:08:48 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1498219689.209042-1251615511', 05:08:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:48 INFO - '_': '/tools/buildbot/bin/python'} 05:08:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:48 INFO - Downloading/unpacking jsonschema==2.5.1 05:08:48 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 05:08:48 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 05:08:48 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 05:08:48 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 05:08:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:08:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:50 INFO - Downloading functools32-3.2.3-2.tar.gz 05:08:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:08:50 INFO - warning: no files found matching '*.txt' 05:08:50 INFO - no previously-included directories found matching 'build' 05:08:50 INFO - no previously-included directories found matching 'dist' 05:08:50 INFO - no previously-included directories found matching '.git*' 05:08:50 INFO - Installing collected packages: jsonschema, functools32 05:08:50 INFO - Running setup.py install for functools32 05:08:50 INFO - warning: no files found matching '*.txt' 05:08:50 INFO - no previously-included directories found matching 'build' 05:08:50 INFO - no previously-included directories found matching 'dist' 05:08:50 INFO - no previously-included directories found matching '.git*' 05:08:50 INFO - Successfully installed jsonschema functools32 05:08:50 INFO - Cleaning up... 05:08:50 INFO - Return code: 0 05:08:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1266a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1408140>, '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 0x1408a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1408ed0>, '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': '923d835db2ba3686ebe126b700000192-1498219689.209042-1251615511', '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 05:08:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:08:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:08:50 INFO - Using env: {'DISPLAY': ':0', 05:08:50 INFO - 'HOME': '/home/cltbld', 05:08:50 INFO - 'LANG': 'en_US.UTF-8', 05:08:50 INFO - 'LANGUAGE': 'en_US:en', 05:08:50 INFO - 'LOGNAME': 'cltbld', 05:08:50 INFO - 'MAIL': '/var/mail/cltbld', 05:08:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:50 INFO - 'MOZ_NO_REMOTE': '1', 05:08:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:50 INFO - 'NO_EM_RESTART': '1', 05:08:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:50 INFO - 'PWD': '/builds/slave/test', 05:08:50 INFO - 'SHELL': '/bin/bash', 05:08:50 INFO - 'SHLVL': '1', 05:08:50 INFO - 'TERM': 'linux', 05:08:50 INFO - 'TMOUT': '86400', 05:08:50 INFO - 'USER': 'cltbld', 05:08:50 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1498219689.209042-1251615511', 05:08:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:50 INFO - '_': '/tools/buildbot/bin/python'} 05:08:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:08:50 INFO - Cleaning up... 05:08:50 INFO - Return code: 0 05:08:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1266a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1408140>, '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 0x1408a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1408ed0>, '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': '923d835db2ba3686ebe126b700000192-1498219689.209042-1251615511', '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 05:08:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:08:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:08:50 INFO - Using env: {'DISPLAY': ':0', 05:08:50 INFO - 'HOME': '/home/cltbld', 05:08:50 INFO - 'LANG': 'en_US.UTF-8', 05:08:50 INFO - 'LANGUAGE': 'en_US:en', 05:08:50 INFO - 'LOGNAME': 'cltbld', 05:08:50 INFO - 'MAIL': '/var/mail/cltbld', 05:08:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:50 INFO - 'MOZ_NO_REMOTE': '1', 05:08:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:50 INFO - 'NO_EM_RESTART': '1', 05:08:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:50 INFO - 'PWD': '/builds/slave/test', 05:08:50 INFO - 'SHELL': '/bin/bash', 05:08:50 INFO - 'SHLVL': '1', 05:08:50 INFO - 'TERM': 'linux', 05:08:50 INFO - 'TMOUT': '86400', 05:08:50 INFO - 'USER': 'cltbld', 05:08:50 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1498219689.209042-1251615511', 05:08:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:50 INFO - '_': '/tools/buildbot/bin/python'} 05:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:51 INFO - Downloading/unpacking blobuploader==1.2.4 05:08:51 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 05:08:51 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 05:08:51 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 05:08:51 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 05:08:52 INFO - Downloading blobuploader-1.2.4.tar.gz 05:08:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:08:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:08:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:52 INFO - Downloading docopt-0.6.1.tar.gz 05:08:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:08:52 INFO - Installing collected packages: blobuploader, requests, docopt 05:08:52 INFO - Running setup.py install for blobuploader 05:08:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:08:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:08:53 INFO - Running setup.py install for requests 05:08:53 INFO - Running setup.py install for docopt 05:08:53 INFO - Successfully installed blobuploader requests docopt 05:08:53 INFO - Cleaning up... 05:08:53 INFO - Return code: 0 05:08:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:53 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')]} 05:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:53 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')]} 05:08:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:53 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 0x108c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1266a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1408140>, '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 0x1408a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1408ed0>, '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': '923d835db2ba3686ebe126b700000192-1498219689.209042-1251615511', '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 05:08:53 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 05:08:53 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 05:08:53 INFO - Using env: {'DISPLAY': ':0', 05:08:53 INFO - 'HOME': '/home/cltbld', 05:08:53 INFO - 'LANG': 'en_US.UTF-8', 05:08:53 INFO - 'LANGUAGE': 'en_US:en', 05:08:53 INFO - 'LOGNAME': 'cltbld', 05:08:53 INFO - 'MAIL': '/var/mail/cltbld', 05:08:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:53 INFO - 'MOZ_NO_REMOTE': '1', 05:08:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:53 INFO - 'NO_EM_RESTART': '1', 05:08:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:53 INFO - 'PWD': '/builds/slave/test', 05:08:53 INFO - 'SHELL': '/bin/bash', 05:08:53 INFO - 'SHLVL': '1', 05:08:53 INFO - 'TERM': 'linux', 05:08:53 INFO - 'TMOUT': '86400', 05:08:53 INFO - 'USER': 'cltbld', 05:08:53 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1498219689.209042-1251615511', 05:08:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:53 INFO - '_': '/tools/buildbot/bin/python'} 05:08:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:08:53 INFO - Running setup.py (path:/tmp/pip-27mj63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:08:53 INFO - Running setup.py (path:/tmp/pip-lWvQJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:08:53 INFO - Running setup.py (path:/tmp/pip-9MAKil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:08:54 INFO - Running setup.py (path:/tmp/pip-CgI0CI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:08:54 INFO - Running setup.py (path:/tmp/pip-CfdtXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:08:54 INFO - Running setup.py (path:/tmp/pip-BtUYRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:08:54 INFO - Running setup.py (path:/tmp/pip-LePMbS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:08:54 INFO - Running setup.py (path:/tmp/pip-xM5b9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:08:54 INFO - Running setup.py (path:/tmp/pip-ktsHCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:08:54 INFO - Running setup.py (path:/tmp/pip-3M3rbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:08:54 INFO - Running setup.py (path:/tmp/pip-d1fsbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:08:54 INFO - Running setup.py (path:/tmp/pip-qSeVAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:08:54 INFO - Running setup.py (path:/tmp/pip-hTtAXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:08:54 INFO - Running setup.py (path:/tmp/pip-rf4GTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:54 INFO - Running setup.py (path:/tmp/pip-q5T3nu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:08:54 INFO - Running setup.py (path:/tmp/pip-kmEMYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:08:54 INFO - Running setup.py (path:/tmp/pip-t579LD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:08:55 INFO - Running setup.py install for manifestparser 05:08:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:08:55 INFO - Running setup.py install for mozcrash 05:08:55 INFO - Running setup.py install for mozdebug 05:08:55 INFO - Running setup.py install for mozdevice 05:08:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:08:55 INFO - Running setup.py install for mozfile 05:08:55 INFO - Running setup.py install for mozhttpd 05:08:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:08:55 INFO - Running setup.py install for mozinfo 05:08:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:08:55 INFO - Running setup.py install for mozInstall 05:08:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:08:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:08:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:08:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:08:55 INFO - Running setup.py install for mozleak 05:08:55 INFO - Running setup.py install for mozlog 05:08:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:08:56 INFO - Running setup.py install for moznetwork 05:08:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:08:56 INFO - Running setup.py install for mozprocess 05:08:56 INFO - Running setup.py install for mozprofile 05:08:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:08:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:08:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:08:56 INFO - Running setup.py install for mozrunner 05:08:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:08:56 INFO - Running setup.py install for mozscreenshot 05:08:56 INFO - Running setup.py install for moztest 05:08:56 INFO - Running setup.py install for mozversion 05:08:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:08:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:08:56 INFO - Cleaning up... 05:08:56 INFO - Return code: 0 05:08:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:56 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')]} 05:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:56 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')]} 05:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:56 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 0x108c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1266a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1408140>, '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 0x1408a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1408ed0>, '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': '923d835db2ba3686ebe126b700000192-1498219689.209042-1251615511', '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 05:08:56 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 05:08:56 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 05:08:56 INFO - Using env: {'DISPLAY': ':0', 05:08:56 INFO - 'HOME': '/home/cltbld', 05:08:56 INFO - 'LANG': 'en_US.UTF-8', 05:08:56 INFO - 'LANGUAGE': 'en_US:en', 05:08:56 INFO - 'LOGNAME': 'cltbld', 05:08:56 INFO - 'MAIL': '/var/mail/cltbld', 05:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:56 INFO - 'MOZ_NO_REMOTE': '1', 05:08:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:56 INFO - 'NO_EM_RESTART': '1', 05:08:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:56 INFO - 'PWD': '/builds/slave/test', 05:08:56 INFO - 'SHELL': '/bin/bash', 05:08:56 INFO - 'SHLVL': '1', 05:08:56 INFO - 'TERM': 'linux', 05:08:56 INFO - 'TMOUT': '86400', 05:08:56 INFO - 'USER': 'cltbld', 05:08:56 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1498219689.209042-1251615511', 05:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:56 INFO - '_': '/tools/buildbot/bin/python'} 05:08:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:08:57 INFO - Running setup.py (path:/tmp/pip-FOk_lf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:08:57 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)) 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:08:57 INFO - Running setup.py (path:/tmp/pip-MGN3jL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:08:57 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)) 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:08:57 INFO - Running setup.py (path:/tmp/pip-Eauuv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:08:57 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)) 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:08:57 INFO - Running setup.py (path:/tmp/pip-kHoe1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:08:57 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)) 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:08:57 INFO - Running setup.py (path:/tmp/pip-Gl84a9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:08:57 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)) 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:08:57 INFO - Running setup.py (path:/tmp/pip-mc0E3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:08:57 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)) 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:08:57 INFO - Running setup.py (path:/tmp/pip-Y49eCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:08:57 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)) 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:08:57 INFO - Running setup.py (path:/tmp/pip-QlZjty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:08:57 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)) 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:08:57 INFO - Running setup.py (path:/tmp/pip-at4YO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:08:57 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)) 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:08:57 INFO - Running setup.py (path:/tmp/pip-y6OxZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:08:57 INFO - Running setup.py (path:/tmp/pip-4QYXUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:08:57 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)) 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:08:57 INFO - Running setup.py (path:/tmp/pip-9T3Hda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:08:57 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)) 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:08:57 INFO - Running setup.py (path:/tmp/pip-ZyNVic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:08:57 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)) 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:08:57 INFO - Running setup.py (path:/tmp/pip-c_9FrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:08:58 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)) 05:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:58 INFO - Running setup.py (path:/tmp/pip-gHQQb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:58 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)) 05:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:08:58 INFO - Running setup.py (path:/tmp/pip-H5LIEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:08:58 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)) 05:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:08:58 INFO - Running setup.py (path:/tmp/pip-blNMX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:58 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)) 05:08:58 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)) 05:08:58 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)) 05:08:58 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)) 05:08:58 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)) 05:08:58 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)) 05:08:58 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)) 05:08:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:08:58 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 05:08:58 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 05:08:58 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 05:08:58 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 05:08:59 INFO - Downloading blessings-1.6.tar.gz 05:08:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:08:59 INFO - Installing collected packages: blessings 05:08:59 INFO - Running setup.py install for blessings 05:08:59 INFO - Successfully installed blessings 05:08:59 INFO - Cleaning up... 05:08:59 INFO - Return code: 0 05:08:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:08:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:08:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:08:59 INFO - Reading from file tmpfile_stdout 05:08:59 INFO - Current package versions: 05:08:59 INFO - argparse == 1.2.1 05:08:59 INFO - blessings == 1.6 05:08:59 INFO - blobuploader == 1.2.4 05:08:59 INFO - docopt == 0.6.1 05:08:59 INFO - functools32 == 3.2.3-2 05:08:59 INFO - jsonschema == 2.5.1 05:08:59 INFO - manifestparser == 1.1 05:08:59 INFO - mozInstall == 1.13 05:08:59 INFO - mozcrash == 1.0 05:08:59 INFO - mozdebug == 0.1 05:08:59 INFO - mozdevice == 0.51 05:08:59 INFO - mozfile == 1.2 05:08:59 INFO - mozhttpd == 0.7 05:08:59 INFO - mozinfo == 0.10 05:08:59 INFO - mozleak == 0.1 05:08:59 INFO - mozlog == 3.4 05:08:59 INFO - moznetwork == 0.27 05:08:59 INFO - mozprocess == 0.25 05:08:59 INFO - mozprofile == 0.28 05:08:59 INFO - mozrunner == 6.13 05:08:59 INFO - mozscreenshot == 0.1 05:08:59 INFO - mozsystemmonitor == 0.3 05:08:59 INFO - moztest == 0.8 05:08:59 INFO - mozversion == 1.4 05:08:59 INFO - psutil == 3.1.1 05:08:59 INFO - requests == 1.2.3 05:08:59 INFO - wsgiref == 0.1.2 05:08:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:59 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')]} 05:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:59 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')]} 05:08:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:59 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 0x108c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1266a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1408140>, '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 0x1408a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1408ed0>, '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': '923d835db2ba3686ebe126b700000192-1498219689.209042-1251615511', '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 05:08:59 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 05:08:59 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 05:08:59 INFO - Using env: {'DISPLAY': ':0', 05:08:59 INFO - 'HOME': '/home/cltbld', 05:08:59 INFO - 'LANG': 'en_US.UTF-8', 05:08:59 INFO - 'LANGUAGE': 'en_US:en', 05:08:59 INFO - 'LOGNAME': 'cltbld', 05:08:59 INFO - 'MAIL': '/var/mail/cltbld', 05:08:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:59 INFO - 'MOZ_NO_REMOTE': '1', 05:08:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:59 INFO - 'NO_EM_RESTART': '1', 05:08:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:59 INFO - 'PWD': '/builds/slave/test', 05:08:59 INFO - 'SHELL': '/bin/bash', 05:08:59 INFO - 'SHLVL': '1', 05:08:59 INFO - 'TERM': 'linux', 05:08:59 INFO - 'TMOUT': '86400', 05:08:59 INFO - 'USER': 'cltbld', 05:08:59 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1498219689.209042-1251615511', 05:08:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:59 INFO - '_': '/tools/buildbot/bin/python'} 05:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:00 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)) 05:09:00 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)) 05:09:00 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)) 05:09:00 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)) 05:09:00 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)) 05:09:00 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)) 05:09:00 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)) 05:09:00 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)) 05:09:00 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)) 05:09:00 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:09:00 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 05:09:00 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 05:09:00 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 05:09:00 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 05:09:01 INFO - Downloading marionette_driver-1.4.0.tar.gz 05:09:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 05:09:01 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)) 05:09:01 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)) 05:09:01 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)) 05:09:01 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)) 05:09:01 INFO - Installing collected packages: marionette-driver 05:09:01 INFO - Running setup.py install for marionette-driver 05:09:01 INFO - Successfully installed marionette-driver 05:09:01 INFO - Cleaning up... 05:09:01 INFO - Return code: 0 05:09:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:01 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 0x108c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1266a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1408140>, '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 0x1408a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1408ed0>, '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': '923d835db2ba3686ebe126b700000192-1498219689.209042-1251615511', '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 05:09:01 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 05:09:01 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 05:09:01 INFO - Using env: {'DISPLAY': ':0', 05:09:01 INFO - 'HOME': '/home/cltbld', 05:09:01 INFO - 'LANG': 'en_US.UTF-8', 05:09:01 INFO - 'LANGUAGE': 'en_US:en', 05:09:01 INFO - 'LOGNAME': 'cltbld', 05:09:01 INFO - 'MAIL': '/var/mail/cltbld', 05:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:01 INFO - 'MOZ_NO_REMOTE': '1', 05:09:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:01 INFO - 'NO_EM_RESTART': '1', 05:09:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:01 INFO - 'PWD': '/builds/slave/test', 05:09:01 INFO - 'SHELL': '/bin/bash', 05:09:01 INFO - 'SHLVL': '1', 05:09:01 INFO - 'TERM': 'linux', 05:09:01 INFO - 'TMOUT': '86400', 05:09:01 INFO - 'USER': 'cltbld', 05:09:01 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1498219689.209042-1251615511', 05:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:01 INFO - '_': '/tools/buildbot/bin/python'} 05:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:09:01 INFO - Cleaning up... 05:09:01 INFO - Return code: 0 05:09:01 INFO - Running post-action listener: _resource_record_post_action 05:09:01 INFO - Running post-action listener: _start_resource_monitoring 05:09:01 INFO - Starting resource monitoring. 05:09:01 INFO - [mozharness: 2017-06-23 12:09:01.619100Z] Finished create-virtualenv step (success) 05:09:01 INFO - [mozharness: 2017-06-23 12:09:01.619564Z] Running install step. 05:09:01 INFO - Running pre-action listener: _resource_record_pre_action 05:09:01 INFO - Running main action method: install 05:09:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:09:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:09:01 INFO - Reading from file tmpfile_stdout 05:09:01 INFO - Detecting whether we're running mozinstall >=1.0... 05:09:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:09:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:09:01 INFO - Reading from file tmpfile_stdout 05:09:01 INFO - Output received: 05:09:01 INFO - Usage: mozinstall [options] installer 05:09:01 INFO - Options: 05:09:01 INFO - -h, --help show this help message and exit 05:09:01 INFO - -d DEST, --destination=DEST 05:09:01 INFO - Directory to install application into. [default: 05:09:01 INFO - "/builds/slave/test"] 05:09:01 INFO - --app=APP Application being installed. [default: firefox] 05:09:01 INFO - mkdir: /builds/slave/test/build/application 05:09:01 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'] 05:09:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:09:19 INFO - Reading from file tmpfile_stdout 05:09:19 INFO - Output received: 05:09:19 INFO - /builds/slave/test/build/application/firefox/firefox 05:09:19 INFO - Running post-action listener: _resource_record_post_action 05:09:19 INFO - [mozharness: 2017-06-23 12:09:19.882488Z] Finished install step (success) 05:09:19 INFO - [mozharness: 2017-06-23 12:09:19.882770Z] Running setup-mitmproxy step. 05:09:19 INFO - Running pre-action listener: _resource_record_pre_action 05:09:19 INFO - Running main action method: setup_mitmproxy 05:09:19 INFO - Skipping: mitmproxy is not required 05:09:19 INFO - Running post-action listener: _resource_record_post_action 05:09:19 INFO - [mozharness: 2017-06-23 12:09:19.884008Z] Finished setup-mitmproxy step (success) 05:09:19 INFO - [mozharness: 2017-06-23 12:09:19.884232Z] Running run-tests step. 05:09:19 INFO - Running pre-action listener: _resource_record_pre_action 05:09:19 INFO - Running main action method: run_tests 05:09:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:09:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:09:19 INFO - Python 2.7.3 05:09:19 INFO - Return code: 0 05:09:19 INFO - grabbing minidump binary from tooltool 05:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:19 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 0x1408140>, '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 0x1408a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1408ed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:09:19 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 05:09:19 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 05:09:19 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 05:09:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:09:20 INFO - Return code: 0 05:09:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:09:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:09:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:09:20 INFO - ENV: RUST_BACKTRACE is now 1 05:09:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:09:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:09:20 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/MTnXcDzoQ9e4HWmOWIKQqw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 05:09:20 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/MTnXcDzoQ9e4HWmOWIKQqw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 05:09:20 INFO - Using env: {'DISPLAY': ':0', 05:09:20 INFO - 'HOME': '/home/cltbld', 05:09:20 INFO - 'LANG': 'en_US.UTF-8', 05:09:20 INFO - 'LANGUAGE': 'en_US:en', 05:09:20 INFO - 'LOGNAME': 'cltbld', 05:09:20 INFO - 'MAIL': '/var/mail/cltbld', 05:09:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:09:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:09:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:20 INFO - 'MOZ_NO_REMOTE': '1', 05:09:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:09:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:20 INFO - 'NO_EM_RESTART': '1', 05:09:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:20 INFO - 'PWD': '/builds/slave/test', 05:09:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:09:20 INFO - 'RUST_BACKTRACE': '1', 05:09:20 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:09:20 INFO - 'SHELL': '/bin/bash', 05:09:20 INFO - 'SHLVL': '1', 05:09:20 INFO - 'TERM': 'linux', 05:09:20 INFO - 'TMOUT': '86400', 05:09:20 INFO - 'USER': 'cltbld', 05:09:20 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1498219689.209042-1251615511', 05:09:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:20 INFO - '_': '/tools/buildbot/bin/python'} 05:09:20 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/MTnXcDzoQ9e4HWmOWIKQqw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 05:09:20 INFO - mozversion application_buildid: 20170623105628 05:09:20 INFO - mozversion application_changeset: 2f10d697c307a09a286faa1f11831644c40f778d 05:09:20 INFO - mozversion application_display_name: Nightly 05:09:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:09:20 INFO - mozversion application_name: Firefox 05:09:20 INFO - mozversion application_remotingname: firefox 05:09:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:09:20 INFO - mozversion application_vendor: Mozilla 05:09:20 INFO - mozversion application_version: 56.0a1 05:09:20 INFO - mozversion platform_buildid: 20170623105628 05:09:20 INFO - mozversion platform_changeset: 2f10d697c307a09a286faa1f11831644c40f778d 05:09:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:09:20 INFO - mozversion platform_version: 56.0a1 05:09:20 INFO - using testdate: 1498219760 05:09:20 INFO - actual date: 1498219760 05:09:20 INFO - starting webserver on 'localhost:49202' 05:09:20 INFO - SUITE-START | Running 2 tests 05:09:20 INFO - TEST-START | dromaeo_css 05:09:20 INFO - operating with platform_type : linux_ 05:09:20 INFO - Initialising browser for dromaeo_css test... 05:09:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49202/getInfo.html -profile /tmp/tmpw3SuuE/profile 05:09:20 INFO - TEST-INFO | started process 13297 (/builds/slave/test/build/application/firefox/firefox http://localhost:49202/getInfo.html) 05:09:26 INFO - TEST-INFO | 13297: exit 0 05:09:26 INFO - Browser initialized. 05:09:26 INFO - Running cycle 1/1 for dromaeo_css test... 05:09:26 INFO - TEST-INFO | started process 13529 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw3SuuE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:09:37 INFO - PID 13529 | RSS: Main: 176422912 05:09:37 INFO - PID 13529 | 05:12:41 INFO - PID 13529 | Cycle 1(1): loaded http://localhost:49202/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49202/tests/dromaeo/cssquery-ext.html) 05:12:43 INFO - PID 13529 | RSS: Main: 181288960 05:12:43 INFO - PID 13529 | 05:15:45 INFO - PID 13529 | Cycle 1(1): loaded http://localhost:49202/tests/dromaeo/cssquery-ext.html (next: http://localhost:49202/tests/dromaeo/cssquery-jquery.html) 05:15:46 INFO - PID 13529 | RSS: Main: 180793344 05:15:46 INFO - PID 13529 | 05:18:47 INFO - PID 13529 | Cycle 1(1): loaded http://localhost:49202/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49202/tests/dromaeo/cssquery-mootools.html) 05:18:48 INFO - PID 13529 | RSS: Main: 181698560 05:18:48 INFO - PID 13529 | 05:21:49 INFO - PID 13529 | Cycle 1(1): loaded http://localhost:49202/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49202/tests/dromaeo/cssquery-prototype.html) 05:21:50 INFO - PID 13529 | RSS: Main: 180924416 05:21:50 INFO - PID 13529 | 05:24:53 INFO - PID 13529 | Cycle 1(1): loaded http://localhost:49202/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49202/tests/dromaeo/cssquery-yui.html) 05:24:53 INFO - PID 13529 | RSS: Main: 183734272 05:24:53 INFO - PID 13529 | 05:27:55 INFO - PID 13529 | Cycle 1(1): loaded http://localhost:49202/tests/dromaeo/cssquery-yui.html (next: http://localhost:49202/tests/dromaeo/cssquery-dojo.html) 05:27:55 INFO - PID 13529 | RSS: Main: 181133312 05:27:55 INFO - PID 13529 | 05:27:55 INFO - PID 13529 | __start_tp_report 05:27:55 INFO - PID 13529 | _x_x_mozilla_page_load 05:27:55 INFO - PID 13529 | _x_x_mozilla_page_load_details 05:27:55 INFO - PID 13529 | |i|pagename|runs| 05:27:55 INFO - PID 13529 | |0;dojo.html;3080.0913730449515;3149.4803357446017;3152.5271209318585;3166.73082787963;3177.9841100794492;6070.878582428349;6098.969505152473;6120.660465672121;6132.324915438575;6196.318404975449;6156.1996940397685;6210.2547694276755;6211.285702144255;6226.626402415858;6276.215473065867;5690.800821971232;5717.914231286513;5738.598298119134;5757.366689664133;5822.883542329151;5803.419658034184;5821.417858214187;5827.475527202551;5827.941720582803;5834;5493.505584497414;5686.402927692574;5691.743871525791;5694.4590263924865;5738.454846789548;5602.7198640068245;5616.606837521375;5657.20799088128;5685.033544297438;5707;5652.463016013472;5684.857878553069;5699.68651724155;5720.08478643415;5725.141228815669;6086.6348019119;6139.38606139387;6148.569600127993;6192.164057852177;6209.441150296495;6449.3873082057125;6659.067730517731;6688;6705.731770729165;6731.394174524267;6551.279359270477;6589.769358072493;6605.141331626905;6640.634765087918;6645.2690204078;6186.505079593711;6191.81424557264;6197.163382943335;6197.690115494207;6211.65835879022;6815.318468153244;6858.588484690935;6866.382025617719;6927.168739751262;6962.582245065312;6345.841353966095;6435;6435.839104022343;6455.935440645533;6578.901316480256;6475.4819614430735;6477.838054048592;6528.151340325728;6602.471802255808;6635.635040072746;6664.067030615718;6682.5322227444585;6683;6693.2972037935315;6718.563293386012;6677.399034086956;6701.698423570951;6722;6732.023856540774;6734.696938637675;5247.055530004636;5274.050670879202;5308.9734551327765;5309.442508536626;5312.442193569696;4533.682642215079;4573.176828170961;4619.653525985497;4626.028534007896;4670.1126785910565;5764.971175144181;5818.301803783573;5825.825225243165;5847.590668653239;5865.4134586541;6730;6757.763478278237;6758.459323254227;6765.830854228585;6768.627725475146;5662.801801936913;5788.797392091256;5816.912746308809;5825.563082768725;5849.181114643953;5788.247527821356;5827.184194212814;5841.824745257649;5868.882622347529;5873.2658417697785;6441.58129721576;6443.96778016107;6483.610983341015;6501.057346684799;6509.349065093453;6733.293004234681;6746.359095885883;6748.527603067738;6753.290904455158;6754.12196414463;6467.741290348334;6495.0906873036865;6499.545031847914;6515.250746164252;6515.641639709862;6315.368463153648;6415.422611964946;6445.5165862561435;6449.451796597342;6550.213974323112;6623.039659249478;6627.701753421011;6629.171353580802;6629.403353698191;6662.400383965466;6503.382178693017;6504.837379065561;6505.447037001908;6506.284308726131;6550.672466376567;6471.094046833353;6482.546221764431;6484.254310754135;6486.54594178403;6497.18785151856;6208.906866396917;6319.652419116993;6351.555391122577;6353.205849268841;6419.229692436751;6408.775692850914;6486.643234622141;6503.804885853432;6517.902231466437;6529.836754081186;6317.210348706411;6401.455876250571;6423.357664233539;6425.389587989133;6446 05:27:55 INFO - PID 13529 | |1;ext.html;818.6807145213368;845.3575282785082;863.8531449653559;886.339676940679;895.6506962284706;39445.605543944555;39904.60095399045;40318.1936361273;40404.79797601015;40431.79784101079;35970.82014589923;36281.637183628154;36487.81756091216;36500.45249321262;36715;6823.658817059152;6901.240863505011;6920.75777347793;6934.098567186284;6959.756408525703;6870.656467176621;6932.341427564374;6997.020417141579;7008.789736307919;7019.227884932653;6986.231514533397;6995.370416662499;7002.579845209279;7008.684609192573;7032.613206273653;6889.414399776025;6928.272531384233;6942.930570694304;6983.092198014251;6985.336393042653;6289.182406287154;7069.929300706978;7556.546607203531;7589.165191828894;7592.126905405894;37063.4440483393;37390.81304593487;37424.25151496955;37505.812470937744;37531;3476.3916314644835;3525.9118522036897;3533.8939831805087;3540.7875527468436;3545.6099829019045;29559;29602.851985740148;29662.40675186484;29823.254418639706;29833.552496712568;3646.0702520857276;3670.5778835434;3687.2441149564543;3708.796016219107;3769.6230376962358;180964;181129;181188;181840;184060;47696.7615161922;48464.7576762114;48550.514494855306;48561.54315370545;48633.27050094251;50297;50397.24404133941;50577.74711126421;50826.74586627117;50831;15562;15636.2181890905;15677.686446271011;15687.764683529756;15725.921370393075;12871.48514059446;12932.935335323264;12937.159084659655;12988.805167922488;12995.025373096867;14204.71590568183;14224.359903804147;14231.359588818528;14274.714505709828;14366.281685915663;5626.521745651666;5685.090385538294;5747.885042299215;5761.798337058183;5798.33319168301;924.4869097650734;929.1916033051289;931.189864817613;990.9900900991042;1001.3341128149699;19867.516635241784;20536.486587835425;21003.78996210049;21142.577148456945;21179;1044.738815296176;1046.2989796836139;1075.6826736112866;1080.2816127275273;1081.4592703648175;10522.210834187466;10774.353538787542;10776.407297598707;10873.673789786319;11124.888751112547;216479;217745;219238;219656;220210;49930.750346248766;50248.74875625598;50553.24170137451;50619.74690126526;50684.493155067976;1403.8736513713611;1447.0811034992855;1451.0640636789212;1452.7094581083825;1459.3505889879114;19967.400977970683;20320.187192512134;20853;20931.581368372244;21210.36368908935;32582.67417325891;32754.67245327516;32799.83600081984;36623;36687.449688255234;180033;181703;181918;182051;182061;30814.383712326075;30848.537271941386;30875.228119297197;32280.192995175308;32709.18227044343;39856.80071599739;40410.39384409295;40728.79635601803;41519;41565.58434415738;28960.696768645885;29390.706092938795;30032.549511757778;30950.690493094782;31641;30191.547126793554;30300.24249393783;31023.379532409675;31580.684193158693;31863.725450982627;33616.49575256422;34372.48441273433;34500.82749586236;34741.65258347384;34908.30183396267;27720;29339.559906600993;29558.55662165112;29950.850245748632;31093;22192.66710999304;23635.881820591476;23835.284941451784;24154.396140096636;24436.87781561081 05:27:55 INFO - PID 13529 | |2;jquery.html;550.8815604645;561.9241402410676;566.603377635655;566.9121286200638;584.643367545797;20711.275105371315;21838;21932.671009934864;22139.889300553514;22150.667739983914;17745.46763597091;18120.54698632535;18197.363092291773;18226;21087.789122108814;6064.87870242596;6222.782202622909;6258.499320054408;6271.372862713738;6276.686165691697;6105.54208434367;6126.540509461808;6162;6165.660888651122;6203.658798766089;6112.960796664578;6143.600665956721;6149.292831324387;6158.261008678965;6176.84557886052;5783.306003279612;5911.438413350725;6090.116933044728;6117.480014198754;6126.540509461808;5626.437356264381;5636.718164091779;5658.236138121383;5672.780352224291;5686.687232202227;25548.616770748453;25950.35124121893;26088.34779130518;26170.869145654342;26190.607140892902;1889.5748456597294;1914.8851068935908;1917.6356492266425;1920.039980009995;1921.6829223178158;16661.750073748903;16774.07742574158;17635.118244087746;17635.206415711324;17826.46520604371;2285.337252196861;2322.256877799105;2354.376090336062;2360.9173678921156;2365.6451532270125;125501;128008;129145.35427322803;129601.35199323943;130060;13129.60611181666;13555.796663050061;14174.929125354307;14332.853371730236;14395.856041439662;21176.364709058755;21193.894030529747;21241.68137477939;21315.46711332229;21317.573648527254;9018.143276388733;9021.368504204642;9052;9104.13510716481;9164.587593558172;8341.708040218564;8474.322054235647;8491.174457023266;8525.275351595184;8529.104444033288;8197.877031844528;8528.65885364591;8644.265237454762;8734;8757.430767000125;2636.419987602763;2712.1321177223494;2734.6581677290337;2790.706975767556;2794.860256987183;856.2581518763045;868.6829307302789;880.5465185429509;897.4391005621486;922.4880191493785;17392.21735021927;18109.094545272685;18111;18362.449126526226;18425.631487370178;905.3210092430677;906.1889608800087;940.7177846645978;950.2160717408166;959.4483172176027;9554.856677149848;9666.75833104178;10018;10204.285700001077;11743.11926605491;471702;474123;480933;483294;489487;105812.47093764636;109579;110534;112534.87465125408;112836;1175.482787573465;1230.0712961714028;1230.2925817654705;1244.4773195258194;1257.8050402187675;18413.171407286438;18454.538636534195;18974.335898243495;19013.04934753229;19032.33386831454;48346.75826620985;50876.491235087175;51001.744991274805;51357.743211283705;51486.74256628693;63344.36655633384;63405.68297158484;64628.67685661541;64691;65328.67335663481;11481.655550333504;11606.30362178272;11789;11839.112066594867;12064.215825971283;17610.559736006704;17732;17744;17837;17932.75840519935;14271.71456570842;14283.857161428252;14320.856791431952;14323.78514322265;14373.568792936228;12422.627321180378;13202.273874936971;13341.599752007456;13848.792268116187;13885.583432497042;13765.311734413439;14258.786118208027;14373.425062997781;14469.421223151377;14476.565703028926;12470.438830252479;12487.375631218221;12511.749765004832;12535.749285014066;12566.874331256937;14587.416503340171;14669.48656797007;14762.114273143647;14774.409023638935;14787.556373308818 05:27:55 INFO - PID 13529 | |3;mootools.html;1358.20544981186;1390.1589538329317;1395.1001603965442;1421.25384173309;1433.9354729037193;12521.436535355919;13249.403776830042;13297;13370.59888203353;13399.397027133778;12578.371081445937;13129.934350328234;13173.077884548085;13201.603951881434;13272.601821945356;2534.4550921551863;2576;2577.9484410311784;2578.22653204039;2597.4285657155397;2473.258022593224;2481.962770558443;2568.268043607572;2576.5491039068183;2588.120039186676;2539.9111031113916;2627.842329460229;2633.460140671167;2645.4312322850583;2651.5757478803393;2537.2007817537415;2549.910753123641;2555.6805399325085;2558.168595206556;2570.203236996518;2463.2733343663663;2547.9108231211817;2595.3381887618534;2596.182202606173;2600.1289567994745;13061.542846000344;13095.214287142802;13126.212427254395;13133.540326088541;13145.802812957812;7106.467014973898;7338.266173382673;7346.5592064476305;7353.264673532604;7356.779296621056;4036.919261614751;4156.56356082613;4243.0269924485265;4271.551487093841;4327.5239723630375;1585.4292454716292;1598.3127255280224;1600.3598560575747;1629.7310943694276;1642.983570164295;20384.592308153755;20429.489262768402;20503.974801260025;20629;20710.482237944023;6020.096985452217;6293.905591416133;6311.453693845037;6389.840253993687;6506.544541882117;14890.478833241;14946.551603451913;14967.176805275596;14988.700225995419;15002.324895379516;7198.640067996579;7285.235050319746;7294.796358600772;7312.926870731331;7340.339369456775;6684.264730879697;6787.66061696923;6849.828754281183;6908.963655451622;6976.127984002;4742.170120228946;4803.687760295569;4813.302071199727;4829.348038014823;4898.853034408973;1404.290833129263;1436.554668052907;1457.1330058615108;1460.50342883418;1466.6260103673494;875.5403413207989;894.7584152278848;905.0813424374134;927.2165020557618;937.5827756648363;7133.179684336368;7314.524555903849;7500.512466689648;7746.109197442253;7899.763007109796;673.3771261583016;690.2821066091209;697.8674051930117;705.0974752317043;710.8755967705631;4546.61353784932;4808.639352048541;4950.628702847229;4971.950280497221;5013.498650134958;16377.754333685005;16399.754003689955;16717.164141792862;16907.83092169087;17059;16667.916660416864;16958.57603559921;17144.057076860892;17148.142592870307;17261.56846078858;9768.827740671164;9817.558209880572;9940.254480914105;10180.745481362877;10219.846702299472;7057.541259818096;7176.820579485555;7360.96319518399;7670.156282808998;7744.186860379805;14727.470097897418;15087;15237.847621523642;15260.694786104437;15375.846241537889;14469.421223150955;15313.46402875894;15629.06225626466;15698.566722158084;15910.443134490237;10772.946135269274;11195.44022798873;11199.776004480027;11209.047230985458;11212.159088068265;12411.255324680547;12482.937585312015;12518.37408129608;12622.305773182563;12643.810342844681;9516.143547080796;9972.102510773775;9988.350757200758;10130.8480372793;10221;9440.811183776423;9524.142827145313;9672.758181045248;9864.062914023156;9873.50632468388;8189.590520473834;8769.91230087691;8841.646334146562;8880.200781929658;8903.3322500814;6311.116443697978;6389.616623002449;6596.076549283201;6622.1722284714415;6720.462363011045;6619.073329733745;6678.7328506859185;6700.865982680221;6800.183977922681;6903.6203008835 05:27:55 INFO - PID 13529 | |4;prototype.html;484.6922204400205;489.99510004899963;497.60191846522775;511.2637801565745;522.2401405954337;6211.8757624847585;6327.398897104774;6369.299377068519;6382.840428989278;6402.231732192132;6149.3235744068115;6213.440790328869;6224.6887655617265;6291.465225455841;6309.873802523946;5029.5221953914315;5039.916417970136;5041.344625198719;5054.41874184468;5057.974710126444;5034.899302013958;5037.118504261758;5046.97476512617;5054.267131265982;5070.442251352349;4974.278729584208;4991.475895031024;4999.825006124786;5013.774380152902;5018.84943451697;4742.359781429497;4941.431735350445;4946.950530494685;4972.825951091694;4996.975015124919;4408.25059739845;4411.845585404528;4429.933550996738;4432.3794668746405;4446.644268458515;6097.329293777725;6109.908351374733;6127.203463549755;6146.323904370515;6151.384861513858;5706.971465142689;5736.397678243808;5753.769849206027;5761.711914404263;5762.032553235087;6565.967170164166;6590.110335104748;6615.272320044839;6681.930891057407;6682.365175308338;4837.32277481153;4842.491538388489;4860.951390486085;4861.708297502161;4863.294822250789;6968.79093627192;6986.650667466606;7026.473014523931;7033.156021277479;7044.260352662948;5089.949100508948;5093.821716239914;5096.847094587169;5098.821541246039;5107.668001579886;5133.947540754137;5140.948590514122;5144.279800827887;5146.099432599281;5148.99594579061;5740.54075673945;5775.104858746901;5783.450572195635;5787.565932554991;5811.070228763378;6714.429273511806;6733.629650369178;6740.191177058784;6752.696128674222;6753.628550429676;1673.6401673640225;1756.8770186086851;1776.3693888669336;1776.9822301777076;1794.967893461265;1202.6392082375253;1214.8739705515347;1226.2703691303839;1227.2145826670937;1254.730232999891;5646.7859410227;5792.7103644818435;5817.0983497557945;5835.5915085944425;5836.824895253149;6589.209294884645;6758;6777.491688123312;6778.152730908637;6803.4557235422035;5760.596758226884;5762.078067509178;5811;5815.854603634943;5855.268091488564;3603.94594081089;3616.9638303616625;3620.637936206411;3642.453631955228;3649.61679023704;6512.837179070561;6574.737010519621;6577.243616984012;6583.473322134218;6584.144061272004;6892.276310987274;6988.021676965229;7016.333448322402;7033.683484243222;7033.824154396181;6567.408933196035;6576.539642224999;6579.276279609239;6587.703553340111;6591.538592298493;6739.730410783513;6744.7976560703255;6748;6751.189857217166;6773.356531129535;6690.899636505359;6703.865922681616;6722.563033402813;6736.898946515708;6741.831454213684;6256.906146407899;6619.3380661933425;6623.2383275923885;6625.569337993015;6650.20197576294;4961.8511444656715;4999.501445807188;5011.448740638454;5024.874378140429;5040.924386134284;6703.262641109376;6857.55425897315;6872.656367181521;6899.379055884994;6927.792166235021;6639.203295604559;6640.435562977201;6661.367170118831;6670.433013193933;6687.164104486939;6564.4420224281475;6629.5359324846795;6648.501362397937;6661.4004739573675;6665.366790154928;6560.901586476111;6563.818512667765;6577.276499584946;6578.8355291118105;6589.5832396033165;6608.6365249909795;6621.900671490028;6670.799876003728;6681.2650608434005;6699.799006029827;6397.808065758035;6438.7102580384935;6449.355064493513;6468.186338942575;6492.513061520499 05:27:55 INFO - PID 13529 | |5;yui.html;837.8156805502787;857.2670366836355;858.4505916213625;866.6230189867408;869.1569177897442;17604.64790704185;18071.186796594153;18109.909450452764;18213.089345532702;18227.453176404713;16516.25676844542;16525.421610243644;16612.169391530435;17685.82314176858;19257.22971081155;1023.6263763726242;1042.2339580408393;1043.8121138195122;1044.2585764107494;1044.8014877173314;1038.5793753529795;1050.7793363393696;1051.2693677893867;1053.7418332508546;1055.9894401055967;1091.639758879572;1092.3664274720643;1093.371311495893;1095.8739744929317;1096.583298346627;1025.6615316945465;1081.086481922774;1089.841972913931;1090.6673464593296;1095.2825899036145;788.9487183333065;789.7630710786799;793.1632128104847;794.0233512779256;794.8211652378227;18596.16317265713;18660.720089198672;18805.811941880544;18812.717809232872;18852.15165317564;17290.221940012605;18127.546811329692;18208.089595520305;18246.90876545622;18375;14471.493497727633;14615.488457903923;14743;14760.704785904329;14881.70236595273;3544.432890737495;3549.6095429502734;3558.377283975294;3576.3204991051875;3590;102119.22428580592;102836;103751.48124259406;104174;107017.46491267494;14777.113373197428;15008.62478438026;15205.771913421308;15248.313825877862;15275.541733748005;26611.467770644478;27928.30179245535;28087.297817554725;28362.85818570894;28521.71478285232;7810.336121429742;7815.296623303816;7952.3638108951145;7986.401019923529;8005.319547838499;4125.195586860534;4224.324108142682;4227.175700738327;4231.407602935591;4241.1941731071;4723.197056500403;4793.544613261734;4803.231482962779;4813.3983252093485;4828.324034635154;960.9279304052224;996.3175224970918;1007.4156988946394;1014.3305418423953;1015.5328548867456;623.5043140703152;632.7880160146402;640.334052585306;644.3298969072113;657.8421178917121;11173.720656983478;12084.577039803564;12087.516499340103;12207;12254.120281733785;642.8939225027818;653.6470306034784;656.8981807819796;677.9932200678029;678.7081554931328;4799.976000120047;4885.145099607555;4979.9333276690495;5047.268146118866;5171.870703232449;90265.54867225622;95220.52389738007;96263;96305;96958;63643.68178159079;77784.2221577777;78115.60942195366;79054;79717.60141199373;73868;75720.62139689266;78857.60571196993;79820.20179798128;79964;11057.89899919045;12315.753684926072;12410.81383779262;12423.813642795185;12424;33262.66737332693;34522.30955380928;35258.294834102664;35458;35625.287494250486;41875.58124418717;42614.78692606517;44028.77985610051;44094.11811763811;44972.325415119456;17248.913755431142;17447.38934137299;17469.12654367251;17721.05068442496;17735.46793596194;18288.72566911471;18853.057347132864;18914.810851891303;19027.52431189176;19335.4199374019;15864.696110442608;17118.572035699206;17136.057516836692;17146;17588;18167.27330906802;18485.260589576268;18530.44408667742;18581.25674972986;18635.81364186341;16731.498055058368;18177.18202680856;18237;18325.816741832412;18523.036314189663;10918.399488028235;12360.876391236332;13046.217226966412;13532.729345413234;14046.15723056579;12592.937035314764;13725.794113088112;14891.180985045927;14909.179995100374;14912.62718432048 05:27:55 INFO - PID 13529 | __end_tp_report 05:27:55 INFO - PID 13529 | __start_cc_report 05:27:55 INFO - PID 13529 | _x_x_mozilla_cycle_collect,360 05:27:55 INFO - PID 13529 | __end_cc_report 05:27:55 INFO - PID 13529 | __startTimestamp1498220875713__endTimestamp 05:27:55 INFO - PID 13529 | 05:27:55 INFO - PID 13529 | ------- Summary: start ------- 05:27:55 INFO - PID 13529 | Number of tests: 6 05:27:55 INFO - PID 13529 | 05:27:55 INFO - PID 13529 | [#0] dojo.html Cycles:165 Average:6123.29 Median:6401.46 stddev:721.51 (11.3%) stddev-sans-first:683.09 05:27:55 INFO - PID 13529 | Values: 3080.1 3149.5 3152.5 3166.7 3178.0 6070.9 6099.0 6120.7 6132.3 6196.3 6156.2 6210.3 6211.3 6226.6 6276.2 5690.8 5717.9 5738.6 5757.4 5822.9 5803.4 5821.4 5827.5 5827.9 5834.0 5493.5 5686.4 5691.7 5694.5 5738.5 5602.7 5616.6 5657.2 5685.0 5707.0 5652.5 5684.9 5699.7 5720.1 5725.1 6086.6 6139.4 6148.6 6192.2 6209.4 6449.4 6659.1 6688.0 6705.7 6731.4 6551.3 6589.8 6605.1 6640.6 6645.3 6186.5 6191.8 6197.2 6197.7 6211.7 6815.3 6858.6 6866.4 6927.2 6962.6 6345.8 6435.0 6435.8 6455.9 6578.9 6475.5 6477.8 6528.2 6602.5 6635.6 6664.1 6682.5 6683.0 6693.3 6718.6 6677.4 6701.7 6722.0 6732.0 6734.7 5247.1 5274.1 5309.0 5309.4 5312.4 4533.7 4573.2 4619.7 4626.0 4670.1 5765.0 5818.3 5825.8 5847.6 5865.4 6730.0 6757.8 6758.5 6765.8 6768.6 5662.8 5788.8 5816.9 5825.6 5849.2 5788.2 5827.2 5841.8 5868.9 5873.3 6441.6 6444.0 6483.6 6501.1 6509.3 6733.3 6746.4 6748.5 6753.3 6754.1 6467.7 6495.1 6499.5 6515.3 6515.6 6315.4 6415.4 6445.5 6449.5 6550.2 6623.0 6627.7 6629.2 6629.4 6662.4 6503.4 6504.8 6505.4 6506.3 6550.7 6471.1 6482.5 6484.3 6486.5 6497.2 6208.9 6319.7 6351.6 6353.2 6419.2 6408.8 6486.6 6503.8 6517.9 6529.8 6317.2 6401.5 6423.4 6425.4 6446.0 05:27:55 INFO - PID 13529 | 05:27:55 INFO - PID 13529 | [#1] ext.html Cycles:180 Average:35494.59 Median:34436.66 stddev:50520.75 (146.7%) stddev-sans-first:50595.38 05:27:55 INFO - PID 13529 | Values: 818.7 845.4 863.9 886.3 895.7 39445.6 39904.6 40318.2 40404.8 40431.8 35970.8 36281.6 36487.8 36500.5 36715.0 6823.7 6901.2 6920.8 6934.1 6959.8 6870.7 6932.3 6997.0 7008.8 7019.2 6986.2 6995.4 7002.6 7008.7 7032.6 6889.4 6928.3 6942.9 6983.1 6985.3 6289.2 7069.9 7556.5 7589.2 7592.1 37063.4 37390.8 37424.3 37505.8 37531.0 3476.4 3525.9 3533.9 3540.8 3545.6 29559.0 29602.9 29662.4 29823.3 29833.6 3646.1 3670.6 3687.2 3708.8 3769.6 180964.0 181129.0 181188.0 181840.0 184060.0 47696.8 48464.8 48550.5 48561.5 48633.3 50297.0 50397.2 50577.7 50826.7 50831.0 15562.0 15636.2 15677.7 15687.8 15725.9 12871.5 12932.9 12937.2 12988.8 12995.0 14204.7 14224.4 14231.4 14274.7 14366.3 5626.5 5685.1 5747.9 5761.8 5798.3 924.5 929.2 931.2 991.0 1001.3 19867.5 20536.5 21003.8 21142.6 21179.0 1044.7 1046.3 1075.7 1080.3 1081.5 10522.2 10774.4 10776.4 10873.7 11124.9 216479.0 217745.0 219238.0 219656.0 220210.0 49930.8 50248.7 50553.2 50619.7 50684.5 1403.9 1447.1 1451.1 1452.7 1459.4 19967.4 20320.2 20853.0 20931.6 21210.4 32582.7 32754.7 32799.8 36623.0 36687.4 180033.0 181703.0 181918.0 182051.0 182061.0 30814.4 30848.5 30875.2 32280.2 32709.2 39856.8 40410.4 40728.8 41519.0 41565.6 28960.7 29390.7 30032.5 30950.7 31641.0 30191.5 30300.2 31023.4 31580.7 31863.7 33616.5 34372.5 34500.8 34741.7 34908.3 27720.0 29339.6 29558.6 29950.9 31093.0 22192.7 23635.9 23835.3 24154.4 24436.9 05:27:55 INFO - PID 13529 | 05:27:55 INFO - PID 13529 | [#2] jquery.html Cycles:180 Average:32363.54 Median:22036.28 stddev:80689.17 (366.2%) stddev-sans-first:80880.17 05:27:55 INFO - PID 13529 | Values: 550.9 561.9 566.6 566.9 584.6 20711.3 21838.0 21932.7 22139.9 22150.7 17745.5 18120.5 18197.4 18226.0 21087.8 6064.9 6222.8 6258.5 6271.4 6276.7 6105.5 6126.5 6162.0 6165.7 6203.7 6113.0 6143.6 6149.3 6158.3 6176.8 5783.3 5911.4 6090.1 6117.5 6126.5 5626.4 5636.7 5658.2 5672.8 5686.7 25548.6 25950.4 26088.3 26170.9 26190.6 1889.6 1914.9 1917.6 1920.0 1921.7 16661.8 16774.1 17635.1 17635.2 17826.5 2285.3 2322.3 2354.4 2360.9 2365.6 125501.0 128008.0 129145.4 129601.4 130060.0 13129.6 13555.8 14174.9 14332.9 14395.9 21176.4 21193.9 21241.7 21315.5 21317.6 9018.1 9021.4 9052.0 9104.1 9164.6 8341.7 8474.3 8491.2 8525.3 8529.1 8197.9 8528.7 8644.3 8734.0 8757.4 2636.4 2712.1 2734.7 2790.7 2794.9 856.3 868.7 880.5 897.4 922.5 17392.2 18109.1 18111.0 18362.4 18425.6 905.3 906.2 940.7 950.2 959.4 9554.9 9666.8 10018.0 10204.3 11743.1 471702.0 474123.0 480933.0 483294.0 489487.0 105812.5 109579.0 110534.0 112534.9 112836.0 1175.5 1230.1 1230.3 1244.5 1257.8 18413.2 18454.5 18974.3 19013.0 19032.3 48346.8 50876.5 51001.7 51357.7 51486.7 63344.4 63405.7 64628.7 64691.0 65328.7 11481.7 11606.3 11789.0 11839.1 12064.2 17610.6 17732.0 17744.0 17837.0 17932.8 14271.7 14283.9 14320.9 14323.8 14373.6 12422.6 13202.3 13341.6 13848.8 13885.6 13765.3 14258.8 14373.4 14469.4 14476.6 12470.4 12487.4 12511.7 12535.7 12566.9 14587.4 14669.5 14762.1 14774.4 14787.6 05:27:55 INFO - PID 13529 | 05:27:55 INFO - PID 13529 | [#3] mootools.html Cycles:180 Average:8050.49 Median:2591.73 stddev:5316.46 (205.1%) stddev-sans-first:5307.59 05:27:55 INFO - PID 13529 | Values: 1358.2 1390.2 1395.1 1421.3 1433.9 12521.4 13249.4 13297.0 13370.6 13399.4 12578.4 13129.9 13173.1 13201.6 13272.6 2534.5 2576.0 2577.9 2578.2 2597.4 2473.3 2482.0 2568.3 2576.5 2588.1 2539.9 2627.8 2633.5 2645.4 2651.6 2537.2 2549.9 2555.7 2558.2 2570.2 2463.3 2547.9 2595.3 2596.2 2600.1 13061.5 13095.2 13126.2 13133.5 13145.8 7106.5 7338.3 7346.6 7353.3 7356.8 4036.9 4156.6 4243.0 4271.6 4327.5 1585.4 1598.3 1600.4 1629.7 1643.0 20384.6 20429.5 20504.0 20629.0 20710.5 6020.1 6293.9 6311.5 6389.8 6506.5 14890.5 14946.6 14967.2 14988.7 15002.3 7198.6 7285.2 7294.8 7312.9 7340.3 6684.3 6787.7 6849.8 6909.0 6976.1 4742.2 4803.7 4813.3 4829.3 4898.9 1404.3 1436.6 1457.1 1460.5 1466.6 875.5 894.8 905.1 927.2 937.6 7133.2 7314.5 7500.5 7746.1 7899.8 673.4 690.3 697.9 705.1 710.9 4546.6 4808.6 4950.6 4972.0 5013.5 16377.8 16399.8 16717.2 16907.8 17059.0 16667.9 16958.6 17144.1 17148.1 17261.6 9768.8 9817.6 9940.3 10180.7 10219.8 7057.5 7176.8 7361.0 7670.2 7744.2 14727.5 15087.0 15237.8 15260.7 15375.8 14469.4 15313.5 15629.1 15698.6 15910.4 10772.9 11195.4 11199.8 11209.0 11212.2 12411.3 12482.9 12518.4 12622.3 12643.8 9516.1 9972.1 9988.4 10130.8 10221.0 9440.8 9524.1 9672.8 9864.1 9873.5 8189.6 8769.9 8841.6 8880.2 8903.3 6311.1 6389.6 6596.1 6622.2 6720.5 6619.1 6678.7 6700.9 6800.2 6903.6 05:27:55 INFO - PID 13529 | 05:27:55 INFO - PID 13529 | [#4] prototype.html Cycles:180 Average:5571.46 Median:6181.63 stddev:1575.97 (25.5%) stddev-sans-first:1533.44 05:27:55 INFO - PID 13529 | Values: 484.7 490.0 497.6 511.3 522.2 6211.9 6327.4 6369.3 6382.8 6402.2 6149.3 6213.4 6224.7 6291.5 6309.9 5029.5 5039.9 5041.3 5054.4 5058.0 5034.9 5037.1 5047.0 5054.3 5070.4 4974.3 4991.5 4999.8 5013.8 5018.8 4742.4 4941.4 4947.0 4972.8 4997.0 4408.3 4411.8 4429.9 4432.4 4446.6 6097.3 6109.9 6127.2 6146.3 6151.4 5707.0 5736.4 5753.8 5761.7 5762.0 6566.0 6590.1 6615.3 6681.9 6682.4 4837.3 4842.5 4861.0 4861.7 4863.3 6968.8 6986.7 7026.5 7033.2 7044.3 5089.9 5093.8 5096.8 5098.8 5107.7 5133.9 5140.9 5144.3 5146.1 5149.0 5740.5 5775.1 5783.5 5787.6 5811.1 6714.4 6733.6 6740.2 6752.7 6753.6 1673.6 1756.9 1776.4 1777.0 1795.0 1202.6 1214.9 1226.3 1227.2 1254.7 5646.8 5792.7 5817.1 5835.6 5836.8 6589.2 6758.0 6777.5 6778.2 6803.5 5760.6 5762.1 5811.0 5815.9 5855.3 3603.9 3617.0 3620.6 3642.5 3649.6 6512.8 6574.7 6577.2 6583.5 6584.1 6892.3 6988.0 7016.3 7033.7 7033.8 6567.4 6576.5 6579.3 6587.7 6591.5 6739.7 6744.8 6748.0 6751.2 6773.4 6690.9 6703.9 6722.6 6736.9 6741.8 6256.9 6619.3 6623.2 6625.6 6650.2 4961.9 4999.5 5011.4 5024.9 5040.9 6703.3 6857.6 6872.7 6899.4 6927.8 6639.2 6640.4 6661.4 6670.4 6687.2 6564.4 6629.5 6648.5 6661.4 6665.4 6560.9 6563.8 6577.3 6578.8 6589.6 6608.6 6621.9 6670.8 6681.3 6699.8 6397.8 6438.7 6449.4 6468.2 6492.5 05:27:55 INFO - PID 13529 | 05:27:55 INFO - PID 13529 | [#5] yui.html Cycles:180 Average:20419.27 Median:18555.85 stddev:26262.73 (141.5%) stddev-sans-first:26295.24 05:27:55 INFO - PID 13529 | Values: 837.8 857.3 858.5 866.6 869.2 17604.6 18071.2 18109.9 18213.1 18227.5 16516.3 16525.4 16612.2 17685.8 19257.2 1023.6 1042.2 1043.8 1044.3 1044.8 1038.6 1050.8 1051.3 1053.7 1056.0 1091.6 1092.4 1093.4 1095.9 1096.6 1025.7 1081.1 1089.8 1090.7 1095.3 788.9 789.8 793.2 794.0 794.8 18596.2 18660.7 18805.8 18812.7 18852.2 17290.2 18127.5 18208.1 18246.9 18375.0 14471.5 14615.5 14743.0 14760.7 14881.7 3544.4 3549.6 3558.4 3576.3 3590.0 102119.2 102836.0 103751.5 104174.0 107017.5 14777.1 15008.6 15205.8 15248.3 15275.5 26611.5 27928.3 28087.3 28362.9 28521.7 7810.3 7815.3 7952.4 7986.4 8005.3 4125.2 4224.3 4227.2 4231.4 4241.2 4723.2 4793.5 4803.2 4813.4 4828.3 960.9 996.3 1007.4 1014.3 1015.5 623.5 632.8 640.3 644.3 657.8 11173.7 12084.6 12087.5 12207.0 12254.1 642.9 653.6 656.9 678.0 678.7 4800.0 4885.1 4979.9 5047.3 5171.9 90265.5 95220.5 96263.0 96305.0 96958.0 63643.7 77784.2 78115.6 79054.0 79717.6 73868.0 75720.6 78857.6 79820.2 79964.0 11057.9 12315.8 12410.8 12423.8 12424.0 33262.7 34522.3 35258.3 35458.0 35625.3 41875.6 42614.8 44028.8 44094.1 44972.3 17248.9 17447.4 17469.1 17721.1 17735.5 18288.7 18853.1 18914.8 19027.5 19335.4 15864.7 17118.6 17136.1 17146.0 17588.0 18167.3 18485.3 18530.4 18581.3 18635.8 16731.5 18177.2 18237.0 18325.8 18523.0 10918.4 12360.9 13046.2 13532.7 14046.2 12592.9 13725.8 14891.2 14909.2 14912.6 05:27:55 INFO - PID 13529 | -------- Summary: end -------- 05:27:55 INFO - PID 13529 | 05:27:56 INFO - TEST-INFO | 13529: exit 0 05:27:56 INFO - TEST-OK | dromaeo_css | took 1116113ms 05:27:56 INFO - TEST-START | kraken 05:27:56 INFO - operating with platform_type : linux_ 05:27:56 INFO - Initialising browser for kraken test... 05:27:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49202/getInfo.html -profile /tmp/tmpsnBJhp/profile 05:27:56 INFO - TEST-INFO | started process 13948 (/builds/slave/test/build/application/firefox/firefox http://localhost:49202/getInfo.html) 05:28:01 INFO - TEST-INFO | 13948: exit 0 05:28:01 INFO - Browser initialized. 05:28:01 INFO - Running cycle 1/1 for kraken test... 05:28:01 INFO - TEST-INFO | started process 14183 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsnBJhp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:28:13 INFO - PID 14183 | RSS: Main: 169013248 05:28:13 INFO - PID 14183 | 05:28:15 INFO - PID 14183 | Cycle 1(1): loaded http://localhost:49202/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49202/tests/kraken/driver.html?testName=audio-beat-detection) 05:28:16 INFO - PID 14183 | RSS: Main: 173060096 05:28:16 INFO - PID 14183 | 05:28:19 INFO - PID 14183 | Cycle 1(1): loaded http://localhost:49202/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49202/tests/kraken/driver.html?testName=audio-dft) 05:28:19 INFO - PID 14183 | RSS: Main: 173801472 05:28:19 INFO - PID 14183 | 05:28:22 INFO - PID 14183 | Cycle 1(1): loaded http://localhost:49202/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49202/tests/kraken/driver.html?testName=audio-fft) 05:28:23 INFO - PID 14183 | RSS: Main: 168747008 05:28:23 INFO - PID 14183 | 05:28:25 INFO - PID 14183 | Cycle 1(1): loaded http://localhost:49202/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49202/tests/kraken/driver.html?testName=audio-oscillator) 05:28:26 INFO - PID 14183 | RSS: Main: 169889792 05:28:26 INFO - PID 14183 | 05:28:28 INFO - PID 14183 | Cycle 1(1): loaded http://localhost:49202/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49202/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:28:28 INFO - PID 14183 | RSS: Main: 169873408 05:28:28 INFO - PID 14183 | 05:28:31 INFO - PID 14183 | Cycle 1(1): loaded http://localhost:49202/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49202/tests/kraken/driver.html?testName=imaging-darkroom) 05:28:32 INFO - PID 14183 | RSS: Main: 173936640 05:28:32 INFO - PID 14183 | 05:28:36 INFO - PID 14183 | Cycle 1(1): loaded http://localhost:49202/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49202/tests/kraken/driver.html?testName=imaging-desaturate) 05:28:36 INFO - PID 14183 | RSS: Main: 175165440 05:28:36 INFO - PID 14183 | 05:28:39 INFO - PID 14183 | Cycle 1(1): loaded http://localhost:49202/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49202/tests/kraken/driver.html?testName=json-parse-financial) 05:28:40 INFO - PID 14183 | RSS: Main: 174370816 05:28:40 INFO - PID 14183 | 05:28:41 INFO - PID 14183 | Cycle 1(1): loaded http://localhost:49202/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49202/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:28:42 INFO - PID 14183 | RSS: Main: 174235648 05:28:42 INFO - PID 14183 | 05:28:43 INFO - PID 14183 | Cycle 1(1): loaded http://localhost:49202/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49202/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:28:44 INFO - PID 14183 | RSS: Main: 174161920 05:28:44 INFO - PID 14183 | 05:28:46 INFO - PID 14183 | Cycle 1(1): loaded http://localhost:49202/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49202/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:28:47 INFO - PID 14183 | RSS: Main: 174166016 05:28:47 INFO - PID 14183 | 05:28:49 INFO - PID 14183 | Cycle 1(1): loaded http://localhost:49202/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49202/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:28:50 INFO - PID 14183 | RSS: Main: 173887488 05:28:50 INFO - PID 14183 | 05:28:53 INFO - PID 14183 | Cycle 1(1): loaded http://localhost:49202/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49202/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:28:54 INFO - PID 14183 | RSS: Main: 173969408 05:28:54 INFO - PID 14183 | 05:28:56 INFO - PID 14183 | Cycle 1(1): loaded http://localhost:49202/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49202/tests/kraken/driver.html?testName=ai-astar) 05:28:56 INFO - PID 14183 | RSS: Main: 175276032 05:28:56 INFO - PID 14183 | 05:28:56 INFO - PID 14183 | __start_tp_report 05:28:56 INFO - PID 14183 | _x_x_mozilla_page_load 05:28:56 INFO - PID 14183 | _x_x_mozilla_page_load_details 05:28:56 INFO - PID 14183 | |i|pagename|runs| 05:28:56 INFO - PID 14183 | |0;ai-astar;101;108;107;108;108;108;108;108;108;109 05:28:56 INFO - PID 14183 | |1;audio-beat-detection;148;119;153;167;120;149;145;121;176;121 05:28:56 INFO - PID 14183 | |2;audio-dft;164;167;163;164;163;163;163;164;176;174 05:28:56 INFO - PID 14183 | |3;audio-fft;74;75;74;162;74;74;75;78;97;74 05:28:56 INFO - PID 14183 | |4;audio-oscillator;82;82;136;81;83;82;152;82;82;140 05:28:56 INFO - PID 14183 | |5;imaging-gaussian-blur;113;114;115;114;113;114;113;114;115;113 05:28:56 INFO - PID 14183 | |6;imaging-darkroom;150;152;150;149;151;152;149;150;149;151 05:28:56 INFO - PID 14183 | |7;imaging-desaturate;95;95;94;94;96;94;94;94;94;93 05:28:56 INFO - PID 14183 | |8;json-parse-financial;54;53;52;52;59;55;53;52;54;53 05:28:56 INFO - PID 14183 | |9;json-stringify-tinderbox;53;53;52;53;54;53;55;52;53;53 05:28:56 INFO - PID 14183 | |10;stanford-crypto-aes;76;77;76;79;75;77;76;75;76;76 05:28:56 INFO - PID 14183 | |11;stanford-crypto-ccm;127;135;129;128;133;126;133;132;126;157 05:28:56 INFO - PID 14183 | |12;stanford-crypto-pbkdf2;190;197;187;186;185;191;196;185;185;181 05:28:56 INFO - PID 14183 | |13;stanford-crypto-sha256-iterative;74;68;68;68;69;68;72;67;81;66 05:28:56 INFO - PID 14183 | __end_tp_report 05:28:56 INFO - PID 14183 | __start_cc_report 05:28:56 INFO - PID 14183 | _x_x_mozilla_cycle_collect,926 05:28:56 INFO - PID 14183 | __end_cc_report 05:28:56 INFO - PID 14183 | __startTimestamp1498220936407__endTimestamp 05:28:56 INFO - PID 14183 | 05:28:56 INFO - PID 14183 | ------- Summary: start ------- 05:28:56 INFO - PID 14183 | Number of tests: 14 05:28:56 INFO - PID 14183 | 05:28:56 INFO - PID 14183 | [#0] ai-astar Cycles:10 Average:107.30 Median:108.00 stddev:2.26 (2.1%) stddev-sans-first:0.50 05:28:56 INFO - PID 14183 | Values: 101.0 108.0 107.0 108.0 108.0 108.0 108.0 108.0 108.0 109.0 05:28:56 INFO - PID 14183 | 05:28:56 INFO - PID 14183 | [#1] audio-beat-detection Cycles:10 Average:141.90 Median:148.50 stddev:20.79 (14.0%) stddev-sans-first:21.94 05:28:56 INFO - PID 14183 | Values: 148.0 119.0 153.0 167.0 120.0 149.0 145.0 121.0 176.0 121.0 05:28:56 INFO - PID 14183 | 05:28:56 INFO - PID 14183 | [#2] audio-dft Cycles:10 Average:166.10 Median:164.00 stddev:4.86 (3.0%) stddev-sans-first:5.10 05:28:56 INFO - PID 14183 | Values: 164.0 167.0 163.0 164.0 163.0 163.0 163.0 164.0 176.0 174.0 05:28:56 INFO - PID 14183 | 05:28:56 INFO - PID 14183 | [#3] audio-fft Cycles:10 Average:85.70 Median:74.50 stddev:27.73 (37.2%) stddev-sans-first:29.09 05:28:56 INFO - PID 14183 | Values: 74.0 75.0 74.0 162.0 74.0 74.0 75.0 78.0 97.0 74.0 05:28:56 INFO - PID 14183 | 05:28:56 INFO - PID 14183 | [#4] audio-oscillator Cycles:10 Average:100.20 Median:82.00 stddev:29.57 (36.1%) stddev-sans-first:30.62 05:28:56 INFO - PID 14183 | Values: 82.0 82.0 136.0 81.0 83.0 82.0 152.0 82.0 82.0 140.0 05:28:56 INFO - PID 14183 | 05:28:56 INFO - PID 14183 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 05:28:56 INFO - PID 14183 | Values: 113.0 114.0 115.0 114.0 113.0 114.0 113.0 114.0 115.0 113.0 05:28:56 INFO - PID 14183 | 05:28:56 INFO - PID 14183 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:150.50 stddev:1.16 (0.8%) stddev-sans-first:1.22 05:28:56 INFO - PID 14183 | Values: 150.0 152.0 150.0 149.0 151.0 152.0 149.0 150.0 149.0 151.0 05:28:56 INFO - PID 14183 | 05:28:56 INFO - PID 14183 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 05:28:56 INFO - PID 14183 | Values: 95.0 95.0 94.0 94.0 96.0 94.0 94.0 94.0 94.0 93.0 05:28:56 INFO - PID 14183 | 05:28:56 INFO - PID 14183 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:53.50 stddev:2.11 (3.9%) stddev-sans-first:2.24 05:28:56 INFO - PID 14183 | Values: 54.0 53.0 52.0 52.0 59.0 55.0 53.0 52.0 54.0 53.0 05:28:56 INFO - PID 14183 | 05:28:56 INFO - PID 14183 | [#9] json-stringify-tinderbox Cycles:10 Average:53.10 Median:53.00 stddev:0.88 (1.7%) stddev-sans-first:0.93 05:28:56 INFO - PID 14183 | Values: 53.0 53.0 52.0 53.0 54.0 53.0 55.0 52.0 53.0 53.0 05:28:56 INFO - PID 14183 | 05:28:56 INFO - PID 14183 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:76.00 stddev:1.16 (1.5%) stddev-sans-first:1.22 05:28:56 INFO - PID 14183 | Values: 76.0 77.0 76.0 79.0 75.0 77.0 76.0 75.0 76.0 76.0 05:28:56 INFO - PID 14183 | 05:28:56 INFO - PID 14183 | [#11] stanford-crypto-ccm Cycles:10 Average:132.60 Median:132.50 stddev:9.16 (6.9%) stddev-sans-first:9.48 05:28:56 INFO - PID 14183 | Values: 127.0 135.0 129.0 128.0 133.0 126.0 133.0 132.0 126.0 157.0 05:28:56 INFO - PID 14183 | 05:28:56 INFO - PID 14183 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.30 Median:188.50 stddev:5.14 (2.7%) stddev-sans-first:5.42 05:28:56 INFO - PID 14183 | Values: 190.0 197.0 187.0 186.0 185.0 191.0 196.0 185.0 185.0 181.0 05:28:56 INFO - PID 14183 | 05:28:56 INFO - PID 14183 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:68.50 stddev:4.51 (6.6%) stddev-sans-first:4.56 05:28:56 INFO - PID 14183 | Values: 74.0 68.0 68.0 68.0 69.0 68.0 72.0 67.0 81.0 66.0 05:28:56 INFO - PID 14183 | -------- Summary: end -------- 05:28:56 INFO - PID 14183 | 05:28:57 INFO - TEST-INFO | 14183: exit 0 05:28:57 INFO - TEST-OK | kraken | took 60904ms 05:28:57 INFO - SUITE-END | took 1177s 05:28:57 INFO - Completed test suite (00:19:37) 05:28:57 INFO - javascript benchmark 05:28:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8052.675554120311, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3080.0913730449515, 3149.4803357446017, 3152.5271209318585, 3166.73082787963, 3177.9841100794492, 6070.878582428349, 6098.969505152473, 6120.660465672121, 6132.324915438575, 6196.318404975449, 6156.1996940397685, 6210.2547694276755, 6211.285702144255, 6226.626402415858, 6276.215473065867, 5690.800821971232, 5717.914231286513, 5738.598298119134, 5757.366689664133, 5822.883542329151, 5803.419658034184, 5821.417858214187, 5827.475527202551, 5827.941720582803, 5834.0, 5493.505584497414, 5686.402927692574, 5691.743871525791, 5694.4590263924865, 5738.454846789548, 5602.7198640068245, 5616.606837521375, 5657.20799088128, 5685.033544297438, 5707.0, 5652.463016013472, 5684.857878553069, 5699.68651724155, 5720.08478643415, 5725.141228815669, 6086.6348019119, 6139.38606139387, 6148.569600127993, 6192.164057852177, 6209.441150296495, 6449.3873082057125, 6659.067730517731, 6688.0, 6705.731770729165, 6731.394174524267, 6551.279359270477, 6589.769358072493, 6605.141331626905, 6640.634765087918, 6645.2690204078, 6186.505079593711, 6191.81424557264, 6197.163382943335, 6197.690115494207, 6211.65835879022, 6815.318468153244, 6858.588484690935, 6866.382025617719, 6927.168739751262, 6962.582245065312, 6345.841353966095, 6435.0, 6435.839104022343, 6455.935440645533, 6578.901316480256, 6475.4819614430735, 6477.838054048592, 6528.151340325728, 6602.471802255808, 6635.635040072746, 6664.067030615718, 6682.5322227444585, 6683.0, 6693.2972037935315, 6718.563293386012, 6677.399034086956, 6701.698423570951, 6722.0, 6732.023856540774, 6734.696938637675, 5247.055530004636, 5274.050670879202, 5308.9734551327765, 5309.442508536626, 5312.442193569696, 4533.682642215079, 4573.176828170961, 4619.653525985497, 4626.028534007896, 4670.1126785910565, 5764.971175144181, 5818.301803783573, 5825.825225243165, 5847.590668653239, 5865.4134586541, 6730.0, 6757.763478278237, 6758.459323254227, 6765.830854228585, 6768.627725475146, 5662.801801936913, 5788.797392091256, 5816.912746308809, 5825.563082768725, 5849.181114643953, 5788.247527821356, 5827.184194212814, 5841.824745257649, 5868.882622347529, 5873.2658417697785, 6441.58129721576, 6443.96778016107, 6483.610983341015, 6501.057346684799, 6509.349065093453, 6733.293004234681, 6746.359095885883, 6748.527603067738, 6753.290904455158, 6754.12196414463, 6467.741290348334, 6495.0906873036865, 6499.545031847914, 6515.250746164252, 6515.641639709862, 6315.368463153648, 6415.422611964946, 6445.5165862561435, 6449.451796597342, 6550.213974323112, 6623.039659249478, 6627.701753421011, 6629.171353580802, 6629.403353698191, 6662.400383965466, 6503.382178693017, 6504.837379065561, 6505.447037001908, 6506.284308726131, 6550.672466376567, 6471.094046833353, 6482.546221764431, 6484.254310754135, 6486.54594178403, 6497.18785151856, 6208.906866396917, 6319.652419116993, 6351.555391122577, 6353.205849268841, 6419.229692436751, 6408.775692850914, 6486.643234622141, 6503.804885853432, 6517.902231466437, 6529.836754081186, 6317.210348706411, 6401.455876250571, 6423.357664233539, 6425.389587989133, 6446.0], "value": 6069.105635947652, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [818.6807145213368, 845.3575282785082, 863.8531449653559, 886.339676940679, 895.6506962284706, 39445.605543944555, 39904.60095399045, 40318.1936361273, 40404.79797601015, 40431.79784101079, 35970.82014589923, 36281.637183628154, 36487.81756091216, 36500.45249321262, 36715.0, 6823.658817059152, 6901.240863505011, 6920.75777347793, 6934.098567186284, 6959.756408525703, 6870.656467176621, 6932.341427564374, 6997.020417141579, 7008.789736307919, 7019.227884932653, 6986.231514533397, 6995.370416662499, 7002.579845209279, 7008.684609192573, 7032.613206273653, 6889.414399776025, 6928.272531384233, 6942.930570694304, 6983.092198014251, 6985.336393042653, 6289.182406287154, 7069.929300706978, 7556.546607203531, 7589.165191828894, 7592.126905405894, 37063.4440483393, 37390.81304593487, 37424.25151496955, 37505.812470937744, 37531.0, 3476.3916314644835, 3525.9118522036897, 3533.8939831805087, 3540.7875527468436, 3545.6099829019045, 29559.0, 29602.851985740148, 29662.40675186484, 29823.254418639706, 29833.552496712568, 3646.0702520857276, 3670.5778835434, 3687.2441149564543, 3708.796016219107, 3769.6230376962358, 180964.0, 181129.0, 181188.0, 181840.0, 184060.0, 47696.7615161922, 48464.7576762114, 48550.514494855306, 48561.54315370545, 48633.27050094251, 50297.0, 50397.24404133941, 50577.74711126421, 50826.74586627117, 50831.0, 15562.0, 15636.2181890905, 15677.686446271011, 15687.764683529756, 15725.921370393075, 12871.48514059446, 12932.935335323264, 12937.159084659655, 12988.805167922488, 12995.025373096867, 14204.71590568183, 14224.359903804147, 14231.359588818528, 14274.714505709828, 14366.281685915663, 5626.521745651666, 5685.090385538294, 5747.885042299215, 5761.798337058183, 5798.33319168301, 924.4869097650734, 929.1916033051289, 931.189864817613, 990.9900900991042, 1001.3341128149699, 19867.516635241784, 20536.486587835425, 21003.78996210049, 21142.577148456945, 21179.0, 1044.738815296176, 1046.2989796836139, 1075.6826736112866, 1080.2816127275273, 1081.4592703648175, 10522.210834187466, 10774.353538787542, 10776.407297598707, 10873.673789786319, 11124.888751112547, 216479.0, 217745.0, 219238.0, 219656.0, 220210.0, 49930.750346248766, 50248.74875625598, 50553.24170137451, 50619.74690126526, 50684.493155067976, 1403.8736513713611, 1447.0811034992855, 1451.0640636789212, 1452.7094581083825, 1459.3505889879114, 19967.400977970683, 20320.187192512134, 20853.0, 20931.581368372244, 21210.36368908935, 32582.67417325891, 32754.67245327516, 32799.83600081984, 36623.0, 36687.449688255234, 180033.0, 181703.0, 181918.0, 182051.0, 182061.0, 30814.383712326075, 30848.537271941386, 30875.228119297197, 32280.192995175308, 32709.18227044343, 39856.80071599739, 40410.39384409295, 40728.79635601803, 41519.0, 41565.58434415738, 28960.696768645885, 29390.706092938795, 30032.549511757778, 30950.690493094782, 31641.0, 30191.547126793554, 30300.24249393783, 31023.379532409675, 31580.684193158693, 31863.725450982627, 33616.49575256422, 34372.48441273433, 34500.82749586236, 34741.65258347384, 34908.30183396267, 27720.0, 29339.559906600993, 29558.55662165112, 29950.850245748632, 31093.0, 22192.66710999304, 23635.881820591476, 23835.284941451784, 24154.396140096636, 24436.87781561081], "value": 16143.097674964243, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.8815604645, 561.9241402410676, 566.603377635655, 566.9121286200638, 584.643367545797, 20711.275105371315, 21838.0, 21932.671009934864, 22139.889300553514, 22150.667739983914, 17745.46763597091, 18120.54698632535, 18197.363092291773, 18226.0, 21087.789122108814, 6064.87870242596, 6222.782202622909, 6258.499320054408, 6271.372862713738, 6276.686165691697, 6105.54208434367, 6126.540509461808, 6162.0, 6165.660888651122, 6203.658798766089, 6112.960796664578, 6143.600665956721, 6149.292831324387, 6158.261008678965, 6176.84557886052, 5783.306003279612, 5911.438413350725, 6090.116933044728, 6117.480014198754, 6126.540509461808, 5626.437356264381, 5636.718164091779, 5658.236138121383, 5672.780352224291, 5686.687232202227, 25548.616770748453, 25950.35124121893, 26088.34779130518, 26170.869145654342, 26190.607140892902, 1889.5748456597294, 1914.8851068935908, 1917.6356492266425, 1920.039980009995, 1921.6829223178158, 16661.750073748903, 16774.07742574158, 17635.118244087746, 17635.206415711324, 17826.46520604371, 2285.337252196861, 2322.256877799105, 2354.376090336062, 2360.9173678921156, 2365.6451532270125, 125501.0, 128008.0, 129145.35427322803, 129601.35199323943, 130060.0, 13129.60611181666, 13555.796663050061, 14174.929125354307, 14332.853371730236, 14395.856041439662, 21176.364709058755, 21193.894030529747, 21241.68137477939, 21315.46711332229, 21317.573648527254, 9018.143276388733, 9021.368504204642, 9052.0, 9104.13510716481, 9164.587593558172, 8341.708040218564, 8474.322054235647, 8491.174457023266, 8525.275351595184, 8529.104444033288, 8197.877031844528, 8528.65885364591, 8644.265237454762, 8734.0, 8757.430767000125, 2636.419987602763, 2712.1321177223494, 2734.6581677290337, 2790.706975767556, 2794.860256987183, 856.2581518763045, 868.6829307302789, 880.5465185429509, 897.4391005621486, 922.4880191493785, 17392.21735021927, 18109.094545272685, 18111.0, 18362.449126526226, 18425.631487370178, 905.3210092430677, 906.1889608800087, 940.7177846645978, 950.2160717408166, 959.4483172176027, 9554.856677149848, 9666.75833104178, 10018.0, 10204.285700001077, 11743.11926605491, 471702.0, 474123.0, 480933.0, 483294.0, 489487.0, 105812.47093764636, 109579.0, 110534.0, 112534.87465125408, 112836.0, 1175.482787573465, 1230.0712961714028, 1230.2925817654705, 1244.4773195258194, 1257.8050402187675, 18413.171407286438, 18454.538636534195, 18974.335898243495, 19013.04934753229, 19032.33386831454, 48346.75826620985, 50876.491235087175, 51001.744991274805, 51357.743211283705, 51486.74256628693, 63344.36655633384, 63405.68297158484, 64628.67685661541, 64691.0, 65328.67335663481, 11481.655550333504, 11606.30362178272, 11789.0, 11839.112066594867, 12064.215825971283, 17610.559736006704, 17732.0, 17744.0, 17837.0, 17932.75840519935, 14271.71456570842, 14283.857161428252, 14320.856791431952, 14323.78514322265, 14373.568792936228, 12422.627321180378, 13202.273874936971, 13341.599752007456, 13848.792268116187, 13885.583432497042, 13765.311734413439, 14258.786118208027, 14373.425062997781, 14469.421223151377, 14476.565703028926, 12470.438830252479, 12487.375631218221, 12511.749765004832, 12535.749285014066, 12566.874331256937, 14587.416503340171, 14669.48656797007, 14762.114273143647, 14774.409023638935, 14787.556373308818], "value": 10803.556323575707, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.20544981186, 1390.1589538329317, 1395.1001603965442, 1421.25384173309, 1433.9354729037193, 12521.436535355919, 13249.403776830042, 13297.0, 13370.59888203353, 13399.397027133778, 12578.371081445937, 13129.934350328234, 13173.077884548085, 13201.603951881434, 13272.601821945356, 2534.4550921551863, 2576.0, 2577.9484410311784, 2578.22653204039, 2597.4285657155397, 2473.258022593224, 2481.962770558443, 2568.268043607572, 2576.5491039068183, 2588.120039186676, 2539.9111031113916, 2627.842329460229, 2633.460140671167, 2645.4312322850583, 2651.5757478803393, 2537.2007817537415, 2549.910753123641, 2555.6805399325085, 2558.168595206556, 2570.203236996518, 2463.2733343663663, 2547.9108231211817, 2595.3381887618534, 2596.182202606173, 2600.1289567994745, 13061.542846000344, 13095.214287142802, 13126.212427254395, 13133.540326088541, 13145.802812957812, 7106.467014973898, 7338.266173382673, 7346.5592064476305, 7353.264673532604, 7356.779296621056, 4036.919261614751, 4156.56356082613, 4243.0269924485265, 4271.551487093841, 4327.5239723630375, 1585.4292454716292, 1598.3127255280224, 1600.3598560575747, 1629.7310943694276, 1642.983570164295, 20384.592308153755, 20429.489262768402, 20503.974801260025, 20629.0, 20710.482237944023, 6020.096985452217, 6293.905591416133, 6311.453693845037, 6389.840253993687, 6506.544541882117, 14890.478833241, 14946.551603451913, 14967.176805275596, 14988.700225995419, 15002.324895379516, 7198.640067996579, 7285.235050319746, 7294.796358600772, 7312.926870731331, 7340.339369456775, 6684.264730879697, 6787.66061696923, 6849.828754281183, 6908.963655451622, 6976.127984002, 4742.170120228946, 4803.687760295569, 4813.302071199727, 4829.348038014823, 4898.853034408973, 1404.290833129263, 1436.554668052907, 1457.1330058615108, 1460.50342883418, 1466.6260103673494, 875.5403413207989, 894.7584152278848, 905.0813424374134, 927.2165020557618, 937.5827756648363, 7133.179684336368, 7314.524555903849, 7500.512466689648, 7746.109197442253, 7899.763007109796, 673.3771261583016, 690.2821066091209, 697.8674051930117, 705.0974752317043, 710.8755967705631, 4546.61353784932, 4808.639352048541, 4950.628702847229, 4971.950280497221, 5013.498650134958, 16377.754333685005, 16399.754003689955, 16717.164141792862, 16907.83092169087, 17059.0, 16667.916660416864, 16958.57603559921, 17144.057076860892, 17148.142592870307, 17261.56846078858, 9768.827740671164, 9817.558209880572, 9940.254480914105, 10180.745481362877, 10219.846702299472, 7057.541259818096, 7176.820579485555, 7360.96319518399, 7670.156282808998, 7744.186860379805, 14727.470097897418, 15087.0, 15237.847621523642, 15260.694786104437, 15375.846241537889, 14469.421223150955, 15313.46402875894, 15629.06225626466, 15698.566722158084, 15910.443134490237, 10772.946135269274, 11195.44022798873, 11199.776004480027, 11209.047230985458, 11212.159088068265, 12411.255324680547, 12482.937585312015, 12518.37408129608, 12622.305773182563, 12643.810342844681, 9516.143547080796, 9972.102510773775, 9988.350757200758, 10130.8480372793, 10221.0, 9440.811183776423, 9524.142827145313, 9672.758181045248, 9864.062914023156, 9873.50632468388, 8189.590520473834, 8769.91230087691, 8841.646334146562, 8880.200781929658, 8903.3322500814, 6311.116443697978, 6389.616623002449, 6596.076549283201, 6622.1722284714415, 6720.462363011045, 6619.073329733745, 6678.7328506859185, 6700.865982680221, 6800.183977922681, 6903.6203008835], "value": 5932.67954977818, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [484.6922204400205, 489.99510004899963, 497.60191846522775, 511.2637801565745, 522.2401405954337, 6211.8757624847585, 6327.398897104774, 6369.299377068519, 6382.840428989278, 6402.231732192132, 6149.3235744068115, 6213.440790328869, 6224.6887655617265, 6291.465225455841, 6309.873802523946, 5029.5221953914315, 5039.916417970136, 5041.344625198719, 5054.41874184468, 5057.974710126444, 5034.899302013958, 5037.118504261758, 5046.97476512617, 5054.267131265982, 5070.442251352349, 4974.278729584208, 4991.475895031024, 4999.825006124786, 5013.774380152902, 5018.84943451697, 4742.359781429497, 4941.431735350445, 4946.950530494685, 4972.825951091694, 4996.975015124919, 4408.25059739845, 4411.845585404528, 4429.933550996738, 4432.3794668746405, 4446.644268458515, 6097.329293777725, 6109.908351374733, 6127.203463549755, 6146.323904370515, 6151.384861513858, 5706.971465142689, 5736.397678243808, 5753.769849206027, 5761.711914404263, 5762.032553235087, 6565.967170164166, 6590.110335104748, 6615.272320044839, 6681.930891057407, 6682.365175308338, 4837.32277481153, 4842.491538388489, 4860.951390486085, 4861.708297502161, 4863.294822250789, 6968.79093627192, 6986.650667466606, 7026.473014523931, 7033.156021277479, 7044.260352662948, 5089.949100508948, 5093.821716239914, 5096.847094587169, 5098.821541246039, 5107.668001579886, 5133.947540754137, 5140.948590514122, 5144.279800827887, 5146.099432599281, 5148.99594579061, 5740.54075673945, 5775.104858746901, 5783.450572195635, 5787.565932554991, 5811.070228763378, 6714.429273511806, 6733.629650369178, 6740.191177058784, 6752.696128674222, 6753.628550429676, 1673.6401673640225, 1756.8770186086851, 1776.3693888669336, 1776.9822301777076, 1794.967893461265, 1202.6392082375253, 1214.8739705515347, 1226.2703691303839, 1227.2145826670937, 1254.730232999891, 5646.7859410227, 5792.7103644818435, 5817.0983497557945, 5835.5915085944425, 5836.824895253149, 6589.209294884645, 6758.0, 6777.491688123312, 6778.152730908637, 6803.4557235422035, 5760.596758226884, 5762.078067509178, 5811.0, 5815.854603634943, 5855.268091488564, 3603.94594081089, 3616.9638303616625, 3620.637936206411, 3642.453631955228, 3649.61679023704, 6512.837179070561, 6574.737010519621, 6577.243616984012, 6583.473322134218, 6584.144061272004, 6892.276310987274, 6988.021676965229, 7016.333448322402, 7033.683484243222, 7033.824154396181, 6567.408933196035, 6576.539642224999, 6579.276279609239, 6587.703553340111, 6591.538592298493, 6739.730410783513, 6744.7976560703255, 6748.0, 6751.189857217166, 6773.356531129535, 6690.899636505359, 6703.865922681616, 6722.563033402813, 6736.898946515708, 6741.831454213684, 6256.906146407899, 6619.3380661933425, 6623.2383275923885, 6625.569337993015, 6650.20197576294, 4961.8511444656715, 4999.501445807188, 5011.448740638454, 5024.874378140429, 5040.924386134284, 6703.262641109376, 6857.55425897315, 6872.656367181521, 6899.379055884994, 6927.792166235021, 6639.203295604559, 6640.435562977201, 6661.367170118831, 6670.433013193933, 6687.164104486939, 6564.4420224281475, 6629.5359324846795, 6648.501362397937, 6661.4004739573675, 6665.366790154928, 6560.901586476111, 6563.818512667765, 6577.276499584946, 6578.8355291118105, 6589.5832396033165, 6608.6365249909795, 6621.900671490028, 6670.799876003728, 6681.2650608434005, 6699.799006029827, 6397.808065758035, 6438.7102580384935, 6449.355064493513, 6468.186338942575, 6492.513061520499], "value": 5102.7754781980075, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [837.8156805502787, 857.2670366836355, 858.4505916213625, 866.6230189867408, 869.1569177897442, 17604.64790704185, 18071.186796594153, 18109.909450452764, 18213.089345532702, 18227.453176404713, 16516.25676844542, 16525.421610243644, 16612.169391530435, 17685.82314176858, 19257.22971081155, 1023.6263763726242, 1042.2339580408393, 1043.8121138195122, 1044.2585764107494, 1044.8014877173314, 1038.5793753529795, 1050.7793363393696, 1051.2693677893867, 1053.7418332508546, 1055.9894401055967, 1091.639758879572, 1092.3664274720643, 1093.371311495893, 1095.8739744929317, 1096.583298346627, 1025.6615316945465, 1081.086481922774, 1089.841972913931, 1090.6673464593296, 1095.2825899036145, 788.9487183333065, 789.7630710786799, 793.1632128104847, 794.0233512779256, 794.8211652378227, 18596.16317265713, 18660.720089198672, 18805.811941880544, 18812.717809232872, 18852.15165317564, 17290.221940012605, 18127.546811329692, 18208.089595520305, 18246.90876545622, 18375.0, 14471.493497727633, 14615.488457903923, 14743.0, 14760.704785904329, 14881.70236595273, 3544.432890737495, 3549.6095429502734, 3558.377283975294, 3576.3204991051875, 3590.0, 102119.22428580592, 102836.0, 103751.48124259406, 104174.0, 107017.46491267494, 14777.113373197428, 15008.62478438026, 15205.771913421308, 15248.313825877862, 15275.541733748005, 26611.467770644478, 27928.30179245535, 28087.297817554725, 28362.85818570894, 28521.71478285232, 7810.336121429742, 7815.296623303816, 7952.3638108951145, 7986.401019923529, 8005.319547838499, 4125.195586860534, 4224.324108142682, 4227.175700738327, 4231.407602935591, 4241.1941731071, 4723.197056500403, 4793.544613261734, 4803.231482962779, 4813.3983252093485, 4828.324034635154, 960.9279304052224, 996.3175224970918, 1007.4156988946394, 1014.3305418423953, 1015.5328548867456, 623.5043140703152, 632.7880160146402, 640.334052585306, 644.3298969072113, 657.8421178917121, 11173.720656983478, 12084.577039803564, 12087.516499340103, 12207.0, 12254.120281733785, 642.8939225027818, 653.6470306034784, 656.8981807819796, 677.9932200678029, 678.7081554931328, 4799.976000120047, 4885.145099607555, 4979.9333276690495, 5047.268146118866, 5171.870703232449, 90265.54867225622, 95220.52389738007, 96263.0, 96305.0, 96958.0, 63643.68178159079, 77784.2221577777, 78115.60942195366, 79054.0, 79717.60141199373, 73868.0, 75720.62139689266, 78857.60571196993, 79820.20179798128, 79964.0, 11057.89899919045, 12315.753684926072, 12410.81383779262, 12423.813642795185, 12424.0, 33262.66737332693, 34522.30955380928, 35258.294834102664, 35458.0, 35625.287494250486, 41875.58124418717, 42614.78692606517, 44028.77985610051, 44094.11811763811, 44972.325415119456, 17248.913755431142, 17447.38934137299, 17469.12654367251, 17721.05068442496, 17735.46793596194, 18288.72566911471, 18853.057347132864, 18914.810851891303, 19027.52431189176, 19335.4199374019, 15864.696110442608, 17118.572035699206, 17136.057516836692, 17146.0, 17588.0, 18167.27330906802, 18485.260589576268, 18530.44408667742, 18581.25674972986, 18635.81364186341, 16731.498055058368, 18177.18202680856, 18237.0, 18325.816741832412, 18523.036314189663, 10918.399488028235, 12360.876391236332, 13046.217226966412, 13532.729345413234, 14046.15723056579, 12592.937035314764, 13725.794113088112, 14891.180985045927, 14909.179995100374, 14912.62718432048], "value": 8509.051075647942, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1533.6999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 108.0, 107.0, 108.0, 108.0, 108.0, 108.0, 108.0, 108.0, 109.0], "value": 107.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 119.0, 153.0, 167.0, 120.0, 149.0, 145.0, 121.0, 176.0, 121.0], "value": 141.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 167.0, 163.0, 164.0, 163.0, 163.0, 163.0, 164.0, 176.0, 174.0], "value": 166.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 162.0, 74.0, 74.0, 75.0, 78.0, 97.0, 74.0], "value": 85.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 136.0, 81.0, 83.0, 82.0, 152.0, 82.0, 82.0, 140.0], "value": 100.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 115.0, 114.0, 113.0, 114.0, 113.0, 114.0, 115.0, 113.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 152.0, 150.0, 149.0, 151.0, 152.0, 149.0, 150.0, 149.0, 151.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 96.0, 94.0, 94.0, 94.0, 94.0, 93.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 52.0, 52.0, 59.0, 55.0, 53.0, 52.0, 54.0, 53.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 53.0, 54.0, 53.0, 55.0, 52.0, 53.0, 53.0], "value": 53.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 79.0, 75.0, 77.0, 76.0, 75.0, 76.0, 76.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 135.0, 129.0, 128.0, 133.0, 126.0, 133.0, 132.0, 126.0, 157.0], "value": 132.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 197.0, 187.0, 186.0, 185.0, 191.0, 196.0, 185.0, 185.0, 181.0], "value": 188.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 68.0, 68.0, 68.0, 69.0, 68.0, 72.0, 67.0, 81.0, 66.0], "value": 70.1, "unit": "score"}]}]} 05:28:57 INFO - Return code: 0 05:28:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:28:57 INFO - # TBPL SUCCESS # 05:28:57 INFO - Running post-action listener: _resource_record_post_action 05:28:57 INFO - [mozharness: 2017-06-23 12:28:57.759528Z] Finished run-tests step (success) 05:28:57 INFO - Running post-run listener: _resource_record_post_run 05:28:57 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 32768; Write bytes: 438149120; Read time: 28; Write time: 328960 05:28:57 INFO - TinderboxPrint: CPU usage
13.2% 05:28:57 INFO - TinderboxPrint: I/O read bytes / time
32,768 / 28 05:28:57 INFO - TinderboxPrint: I/O write bytes / time
438,149,120 / 328,960 05:28:57 INFO - TinderboxPrint: CPU idle
8,280.5 (86.8%) 05:28:57 INFO - TinderboxPrint: CPU user
1,209.0 (12.7%) 05:28:57 INFO - TinderboxPrint: Swap in / out
0 / 0 05:28:57 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106139648; Read time: 0; Write time: 96276 05:28:57 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:28:57 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 28672; Write bytes: 332009472; Read time: 16; Write time: 232684 05:28:58 INFO - Running post-run listener: _upload_blobber_files 05:28:58 INFO - Blob upload gear active. 05:28:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:28:58 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 05:28:58 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'] 05:28:58 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 05:28:58 INFO - (blobuploader) - INFO - Open directory for files ... 05:28:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:28:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:28:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:59 INFO - (blobuploader) - INFO - Done attempting. 05:28:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:28:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:29:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:07 INFO - (blobuploader) - INFO - Done attempting. 05:29:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:29:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:29:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:29:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:09 INFO - (blobuploader) - INFO - Done attempting. 05:29:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:29:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:29:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:29:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:10 INFO - (blobuploader) - INFO - Done attempting. 05:29:10 INFO - (blobuploader) - INFO - Iteration through files over. 05:29:10 INFO - Return code: 0 05:29:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:29:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:29:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df5f6a240ece7673f1630f73e4aee3b952748fc963a5a86328d5c7386abdac04cffbdec724f9fb27b400be05916820a2a1052c7131d415927e7876aa3e2eaf5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/366f07c00682186b8df1ffa652a6b46076944fdb33011f279af359f86fdc52d362ebfa3ed712aec740f57726e9a3c3baaceab785799765880c9ab4e4f95957cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/66454177d3ca029c32663af8a3a9f954eea8b9176235cf208cdac236c0c432a2ef02e14222014c7915495a0f291057926bb57c9fdb901c85d332837ce7eeae56", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dfa9427189059bb61dbe33634611b4e1a1841fe04f9ecda05e76376df5b5aaeff6367441428f9a7471e6dfff0de7577a3fba9eb6bac2f2bf9ff20c915a0a3a62"} 05:29:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:29:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:29:10 INFO - Contents: 05:29:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df5f6a240ece7673f1630f73e4aee3b952748fc963a5a86328d5c7386abdac04cffbdec724f9fb27b400be05916820a2a1052c7131d415927e7876aa3e2eaf5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/366f07c00682186b8df1ffa652a6b46076944fdb33011f279af359f86fdc52d362ebfa3ed712aec740f57726e9a3c3baaceab785799765880c9ab4e4f95957cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/66454177d3ca029c32663af8a3a9f954eea8b9176235cf208cdac236c0c432a2ef02e14222014c7915495a0f291057926bb57c9fdb901c85d332837ce7eeae56", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dfa9427189059bb61dbe33634611b4e1a1841fe04f9ecda05e76376df5b5aaeff6367441428f9a7471e6dfff0de7577a3fba9eb6bac2f2bf9ff20c915a0a3a62"} 05:29:10 INFO - Running post-run listener: copy_logs_to_upload_dir 05:29:10 INFO - Copying logs to upload dir... 05:29:10 INFO - mkdir: /builds/slave/test/build/upload/logs 05:29:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.359541 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-06-23 05:29:09.654727) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-23 05:29:09.657936) ========= 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=923d835db2ba3686ebe126b700000192-1498219689.209042-1251615511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df5f6a240ece7673f1630f73e4aee3b952748fc963a5a86328d5c7386abdac04cffbdec724f9fb27b400be05916820a2a1052c7131d415927e7876aa3e2eaf5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/366f07c00682186b8df1ffa652a6b46076944fdb33011f279af359f86fdc52d362ebfa3ed712aec740f57726e9a3c3baaceab785799765880c9ab4e4f95957cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/66454177d3ca029c32663af8a3a9f954eea8b9176235cf208cdac236c0c432a2ef02e14222014c7915495a0f291057926bb57c9fdb901c85d332837ce7eeae56", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dfa9427189059bb61dbe33634611b4e1a1841fe04f9ecda05e76376df5b5aaeff6367441428f9a7471e6dfff0de7577a3fba9eb6bac2f2bf9ff20c915a0a3a62"} build_url:https://queue.taskcluster.net/v1/task/MTnXcDzoQ9e4HWmOWIKQqw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011324 build_url: 'https://queue.taskcluster.net/v1/task/MTnXcDzoQ9e4HWmOWIKQqw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df5f6a240ece7673f1630f73e4aee3b952748fc963a5a86328d5c7386abdac04cffbdec724f9fb27b400be05916820a2a1052c7131d415927e7876aa3e2eaf5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/366f07c00682186b8df1ffa652a6b46076944fdb33011f279af359f86fdc52d362ebfa3ed712aec740f57726e9a3c3baaceab785799765880c9ab4e4f95957cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/66454177d3ca029c32663af8a3a9f954eea8b9176235cf208cdac236c0c432a2ef02e14222014c7915495a0f291057926bb57c9fdb901c85d332837ce7eeae56", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dfa9427189059bb61dbe33634611b4e1a1841fe04f9ecda05e76376df5b5aaeff6367441428f9a7471e6dfff0de7577a3fba9eb6bac2f2bf9ff20c915a0a3a62"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-23 05:29:09.683034) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-23 05:29:09.683360) ========= 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=923d835db2ba3686ebe126b700000192-1498219689.209042-1251615511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004487 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-23 05:29:09.766524) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-23 05:29:09.766836) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-23 05:29:09.767125) ========= ========= Total master_lag: 0.16 =========