builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-038 starttime: 1497888948.28 results: success (0) revision: 72346a4d6afcc17504f911190dbf470100e879ec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-19 09:15:48.284598) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-19 09:15:48.288087) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-19 09:15:48.288617) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-19 09:15:48.307224) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-19 09:15:48.307489) ========= 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=8783db0840cc980e80bb0bd400000236-1497882641.372768-1313985863 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-19 09:15:48-- 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% 225M=0s 2017-06-19 09:15:48 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.076778 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-19 09:15:48.399968) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-19 09:15:48.400293) ========= 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=8783db0840cc980e80bb0bd400000236-1497882641.372768-1313985863 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023131 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-19 09:15:48.449531) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-19 09:15:48.452879) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 72346a4d6afcc17504f911190dbf470100e879ec --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 72346a4d6afcc17504f911190dbf470100e879ec --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=8783db0840cc980e80bb0bd400000236-1497882641.372768-1313985863 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-19 09:15:49,006 truncating revision to first 12 chars 2017-06-19 09:15:49,006 Setting DEBUG logging. 2017-06-19 09:15:49,006 attempt 1/10 2017-06-19 09:15:49,007 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/72346a4d6afc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-19 09:15:49,848 unpacking tar archive at: mozilla-central-72346a4d6afc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.177852 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-19 09:15:49.643126) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-19 09:15:49.643448) ========= script_repo_revision: 72346a4d6afcc17504f911190dbf470100e879ec ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-19 09:15:49.647342) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-19 09:15:49.647617) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-19 09:15:49.667944) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-06-19 09:15:49.668221) ========= /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=8783db0840cc980e80bb0bd400000236-1497882641.372768-1313985863 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:15:50 INFO - MultiFileLogger online at 20170619 09:15:50 in /builds/slave/test 09:15:50 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 09:15:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:15:50 INFO - {'append_to_log': False, 09:15:50 INFO - 'base_work_dir': '/builds/slave/test', 09:15:50 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:15:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:15:50 INFO - 'branch': 'Firefox-Non-PGO', 09:15:50 INFO - 'buildbot_json_path': 'buildprops.json', 09:15:50 INFO - 'config_files': ('talos/linux_config.py',), 09:15:50 INFO - 'default_actions': ('clobber', 09:15:50 INFO - 'read-buildbot-config', 09:15:50 INFO - 'download-and-extract', 09:15:50 INFO - 'populate-webroot', 09:15:50 INFO - 'create-virtualenv', 09:15:50 INFO - 'install', 09:15:50 INFO - 'setup-mitmproxy', 09:15:50 INFO - 'run-tests'), 09:15:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:15:50 INFO - 'download_minidump_stackwalk': True, 09:15:50 INFO - 'download_symbols': 'ondemand', 09:15:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:15:50 INFO - 'tooltool.py': '/tools/tooltool.py', 09:15:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:15:50 INFO - '/tools/misc-python/virtualenv.py')}, 09:15:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:15:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:15:50 INFO - 'gecko_profile': False, 09:15:50 INFO - 'gecko_profile_interval': 0, 09:15:50 INFO - 'installer_path': 'installer.exe', 09:15:50 INFO - 'log_level': 'info', 09:15:50 INFO - 'log_name': 'talos', 09:15:50 INFO - 'log_to_console': True, 09:15:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:15:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:15:50 INFO - 'opt_config_files': (), 09:15:50 INFO - 'pip_index': False, 09:15:50 INFO - 'suite': 'dromaeojs-e10s', 09:15:50 INFO - 'system_bits': '32', 09:15:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:15:50 INFO - 'title': 'talos-linux64-ix-038', 09:15:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:15:50 INFO - 'use_talos_json': True, 09:15:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:15:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:15:50 INFO - 'work_dir': 'build'} 09:15:50 INFO - [mozharness: 2017-06-19 16:15:50.328858Z] Running clobber step. 09:15:50 INFO - Running pre-action listener: _resource_record_pre_action 09:15:50 INFO - Running main action method: clobber 09:15:50 INFO - rmtree: /builds/slave/test/build 09:15:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:15:51 INFO - Running post-action listener: _resource_record_post_action 09:15:51 INFO - [mozharness: 2017-06-19 16:15:51.348861Z] Finished clobber step (success) 09:15:51 INFO - [mozharness: 2017-06-19 16:15:51.348960Z] Running read-buildbot-config step. 09:15:51 INFO - Running pre-action listener: _resource_record_pre_action 09:15:51 INFO - Running main action method: read_buildbot_config 09:15:51 INFO - Using buildbot properties: 09:15:51 INFO - { 09:15:51 INFO - "project": "", 09:15:51 INFO - "product": "firefox", 09:15:51 INFO - "who": "ffxbld@noreply.mozilla.org", 09:15:51 INFO - "installer_path": "public/build/target.tar.bz2", 09:15:51 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:15:51 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:15:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 09:15:51 INFO - "stage_platform": "linux64", 09:15:51 INFO - "basedir": "/builds/slave/test", 09:15:51 INFO - "buildnumber": 676, 09:15:51 INFO - "platform": "ubuntu64_hw", 09:15:51 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:15:51 INFO - "slavebuilddir": "test", 09:15:51 INFO - "taskId": "CTusCVebR2ealbH912oblw", 09:15:51 INFO - "branch": "mozilla-central", 09:15:51 INFO - "script_repo_revision": "production", 09:15:51 INFO - "revision": "72346a4d6afcc17504f911190dbf470100e879ec", 09:15:51 INFO - "slavename": "talos-linux64-ix-038", 09:15:51 INFO - "repo_path": "mozilla-central" 09:15:51 INFO - } 09:15:51 INFO - Finding installer, test and symbols from parent task. 09:15:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CTusCVebR2ealbH912oblw'}, attempt #1 09:15:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CTusCVebR2ealbH912oblw'}, attempt #1 09:15:52 INFO - Task dependencies: e2STNDhHQv2F-9vOiEUE3w 09:15:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e2STNDhHQv2F-9vOiEUE3w'}, attempt #1 09:15:52 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/e2STNDhHQv2F-9vOiEUE3w/artifacts/public/build/target.tar.bz2 09:15:52 INFO - Set test_url: https://queue.taskcluster.net/v1/task/e2STNDhHQv2F-9vOiEUE3w/artifacts/public/build/test_packages.json 09:15:52 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/e2STNDhHQv2F-9vOiEUE3w/artifacts/public/build/target.crashreporter-symbols.zip 09:15:52 INFO - Running post-action listener: _resource_record_post_action 09:15:52 INFO - [mozharness: 2017-06-19 16:15:52.862187Z] Finished read-buildbot-config step (success) 09:15:52 INFO - [mozharness: 2017-06-19 16:15:52.862404Z] Running download-and-extract step. 09:15:52 INFO - Running pre-action listener: _resource_record_pre_action 09:15:52 INFO - Running main action method: download_and_extract 09:15:52 INFO - mkdir: /builds/slave/test/build/tests 09:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:52 INFO - trying https://queue.taskcluster.net/v1/task/e2STNDhHQv2F-9vOiEUE3w/artifacts/public/build/target.test_packages.json 09:15:52 INFO - Downloading https://queue.taskcluster.net/v1/task/e2STNDhHQv2F-9vOiEUE3w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:15:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e2STNDhHQv2F-9vOiEUE3w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:15:53 INFO - Downloaded 989 bytes. 09:15:53 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:15:53 INFO - Using the following test package requirements: 09:15:53 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:15:53 INFO - u'common': [u'target.common.tests.zip'], 09:15:53 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:15:53 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:15:53 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:15:53 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:15:53 INFO - u'mozbase': [u'target.common.tests.zip'], 09:15:53 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:15:53 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:15:53 INFO - u'web-platform': [u'target.common.tests.zip', 09:15:53 INFO - u'target.web-platform.tests.tar.gz'], 09:15:53 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:15:53 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:15:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e2STNDhHQv2F-9vOiEUE3w/artifacts/public/build/target.common.tests.zip 09:15:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e2STNDhHQv2F-9vOiEUE3w/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:15:53 INFO - Fetch https://queue.taskcluster.net/v1/task/e2STNDhHQv2F-9vOiEUE3w/artifacts/public/build/target.common.tests.zip into memory 09:15:55 INFO - Content-Length response header: 67979569 09:15:55 INFO - Bytes received: 67979569 09:16:06 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:16:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e2STNDhHQv2F-9vOiEUE3w/artifacts/public/build/target.common.tests.zip 09:16:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e2STNDhHQv2F-9vOiEUE3w/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:16:06 INFO - Fetch https://queue.taskcluster.net/v1/task/e2STNDhHQv2F-9vOiEUE3w/artifacts/public/build/target.common.tests.zip into memory 09:16:07 INFO - Content-Length response header: 67979569 09:16:07 INFO - Bytes received: 67979569 09:16:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e2STNDhHQv2F-9vOiEUE3w/artifacts/public/build/target.talos.tests.zip 09:16:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e2STNDhHQv2F-9vOiEUE3w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:16:19 INFO - Fetch https://queue.taskcluster.net/v1/task/e2STNDhHQv2F-9vOiEUE3w/artifacts/public/build/target.talos.tests.zip into memory 09:16:19 INFO - Content-Length response header: 14454970 09:16:19 INFO - Bytes received: 14454970 09:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:20 INFO - trying https://queue.taskcluster.net/v1/task/e2STNDhHQv2F-9vOiEUE3w/artifacts/public/build/target.tar.bz2 09:16:20 INFO - Downloading https://queue.taskcluster.net/v1/task/e2STNDhHQv2F-9vOiEUE3w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:16:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e2STNDhHQv2F-9vOiEUE3w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:16:21 INFO - Downloaded 59350951 bytes. 09:16:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e2STNDhHQv2F-9vOiEUE3w/artifacts/public/build/target.tar.bz2 09:16:21 INFO - mkdir: /builds/slave/test/properties 09:16:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:16:21 INFO - Writing to file /builds/slave/test/properties/build_url 09:16:21 INFO - Contents: 09:16:21 INFO - build_url:https://queue.taskcluster.net/v1/task/e2STNDhHQv2F-9vOiEUE3w/artifacts/public/build/target.tar.bz2 09:16:21 INFO - Running post-action listener: _resource_record_post_action 09:16:21 INFO - Running post-action listener: set_extra_try_arguments 09:16:21 INFO - [mozharness: 2017-06-19 16:16:21.158338Z] Finished download-and-extract step (success) 09:16:21 INFO - [mozharness: 2017-06-19 16:16:21.158434Z] Running populate-webroot step. 09:16:21 INFO - Running pre-action listener: _resource_record_pre_action 09:16:21 INFO - Running main action method: populate_webroot 09:16:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:16:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:16:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:16:21 INFO - '--tppagecycles', 09:16:21 INFO - '7'], 09:16:21 INFO - 'tests': ['tsvgm']}}, 09:16:21 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:16:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:16:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:16:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:16:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:16:21 INFO - 'talos_options': ['--disable-e10s'], 09:16:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:16:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:16:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:16:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:16:21 INFO - 'talos_options': ['--disable-e10s'], 09:16:21 INFO - 'tests': ['damp', 'tps']}, 09:16:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:16:21 INFO - 'tests': ['damp', 'tps']}, 09:16:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:16:21 INFO - 'tests': ['dromaeo_dom']}, 09:16:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:16:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:16:21 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:16:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:16:21 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:16:21 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:16:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:16:21 INFO - 'tests': ['a11yr', 09:16:21 INFO - 'ts_paint', 09:16:21 INFO - 'tpaint', 09:16:21 INFO - 'sessionrestore', 09:16:21 INFO - 'sessionrestore_no_auto_restore', 09:16:21 INFO - 'tabpaint']}, 09:16:21 INFO - 'other-e10s': {'tests': ['a11yr', 09:16:21 INFO - 'ts_paint', 09:16:21 INFO - 'tpaint', 09:16:21 INFO - 'sessionrestore', 09:16:21 INFO - 'sessionrestore_no_auto_restore', 09:16:21 INFO - 'tabpaint']}, 09:16:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:16:21 INFO - 'ts_paint', 09:16:21 INFO - 'tpaint', 09:16:21 INFO - 'sessionrestore', 09:16:21 INFO - 'sessionrestore_no_auto_restore', 09:16:21 INFO - 'tabpaint']}, 09:16:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:16:21 INFO - 'ts_paint', 09:16:21 INFO - 'tpaint', 09:16:21 INFO - 'sessionrestore', 09:16:21 INFO - 'sessionrestore_no_auto_restore', 09:16:21 INFO - 'tabpaint']}, 09:16:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:16:21 INFO - 'tests': ['a11yr', 09:16:21 INFO - 'ts_paint', 09:16:21 INFO - 'tpaint', 09:16:21 INFO - 'sessionrestore', 09:16:21 INFO - 'sessionrestore_no_auto_restore', 09:16:21 INFO - 'tabpaint']}, 09:16:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:16:21 INFO - 'tests': ['a11yr', 09:16:21 INFO - 'ts_paint', 09:16:21 INFO - 'tpaint', 09:16:21 INFO - 'sessionrestore', 09:16:21 INFO - 'sessionrestore_no_auto_restore', 09:16:21 INFO - 'tabpaint']}, 09:16:21 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:16:21 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:16:21 INFO - 'bloom_basic_ref']}, 09:16:21 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:16:21 INFO - 'talos_options': ['--mitmproxy', 09:16:21 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:16:21 INFO - '--firstNonBlankPaint'], 09:16:21 INFO - 'tests': ['quantum_pageload_google', 09:16:21 INFO - 'quantum_pageload_youtube', 09:16:21 INFO - 'quantum_pageload_amazon', 09:16:21 INFO - 'quantum_pageload_facebook']}, 09:16:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:16:21 INFO - 'tests': ['tsvgx', 09:16:21 INFO - 'tsvgr_opacity', 09:16:21 INFO - 'tart', 09:16:21 INFO - 'tscrollx', 09:16:21 INFO - 'cart', 09:16:21 INFO - 'tsvg_static']}, 09:16:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:16:21 INFO - 'tsvgr_opacity', 09:16:21 INFO - 'tart', 09:16:21 INFO - 'tscrollx', 09:16:21 INFO - 'cart', 09:16:21 INFO - 'tsvg_static']}, 09:16:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:16:21 INFO - 'talos_options': ['--disable-e10s'], 09:16:21 INFO - 'tests': ['tp5o']}, 09:16:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:16:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:16:21 INFO - 'talos_options': ['--disable-e10s', 09:16:21 INFO - '--xperf_path', 09:16:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:16:21 INFO - 'tests': ['tp5n']}, 09:16:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:16:21 INFO - 'talos_options': ['--xperf_path', 09:16:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:16:21 INFO - 'tests': ['tp5n']}}, 09:16:21 INFO - 'talos.zip': {'path': '', 09:16:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:16:21 INFO - Running post-action listener: _resource_record_post_action 09:16:21 INFO - [mozharness: 2017-06-19 16:16:21.173011Z] Finished populate-webroot step (success) 09:16:21 INFO - [mozharness: 2017-06-19 16:16:21.173100Z] Running create-virtualenv step. 09:16:21 INFO - Running pre-action listener: _resource_record_pre_action 09:16:21 INFO - Running main action method: create_virtualenv 09:16:21 INFO - Creating virtualenv /builds/slave/test/build/venv 09:16:21 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:16:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:16:21 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:16:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:16:21 INFO - Using real prefix '/usr' 09:16:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:16:21 INFO - Installing distribute.............................................................................................................................................................................................done. 09:16:23 INFO - Installing pip.................done. 09:16:23 INFO - Return code: 0 09:16:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:16:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:16:23 INFO - Reading from file tmpfile_stdout 09:16:23 INFO - Output received: 09:16:23 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:16:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:16:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:23 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 0xb5b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed7140>, '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 0xed7a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed7ed0>, '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': '8783db0840cc980e80bb0bd400000236-1497882641.372768-1313985863', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:16:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:16:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:16:23 INFO - Using env: {'DISPLAY': ':0', 09:16:23 INFO - 'HOME': '/home/cltbld', 09:16:23 INFO - 'LANG': 'en_US.UTF-8', 09:16:23 INFO - 'LANGUAGE': 'en_US:en', 09:16:23 INFO - 'LOGNAME': 'cltbld', 09:16:23 INFO - 'MAIL': '/var/mail/cltbld', 09:16:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:23 INFO - 'MOZ_NO_REMOTE': '1', 09:16:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:23 INFO - 'NO_EM_RESTART': '1', 09:16:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:23 INFO - 'PWD': '/builds/slave/test', 09:16:23 INFO - 'SHELL': '/bin/bash', 09:16:23 INFO - 'SHLVL': '1', 09:16:23 INFO - 'TERM': 'linux', 09:16:23 INFO - 'TMOUT': '86400', 09:16:23 INFO - 'USER': 'cltbld', 09:16:23 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1497882641.372768-1313985863', 09:16:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:23 INFO - '_': '/tools/buildbot/bin/python'} 09:16:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:24 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:16:24 INFO - Cleaning up... 09:16:24 INFO - Return code: 0 09:16:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xb5b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed7140>, '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 0xed7a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed7ed0>, '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': '8783db0840cc980e80bb0bd400000236-1497882641.372768-1313985863', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:16:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:16:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:16:24 INFO - Using env: {'DISPLAY': ':0', 09:16:24 INFO - 'HOME': '/home/cltbld', 09:16:24 INFO - 'LANG': 'en_US.UTF-8', 09:16:24 INFO - 'LANGUAGE': 'en_US:en', 09:16:24 INFO - 'LOGNAME': 'cltbld', 09:16:24 INFO - 'MAIL': '/var/mail/cltbld', 09:16:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:24 INFO - 'MOZ_NO_REMOTE': '1', 09:16:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:24 INFO - 'NO_EM_RESTART': '1', 09:16:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:24 INFO - 'PWD': '/builds/slave/test', 09:16:24 INFO - 'SHELL': '/bin/bash', 09:16:24 INFO - 'SHLVL': '1', 09:16:24 INFO - 'TERM': 'linux', 09:16:24 INFO - 'TMOUT': '86400', 09:16:24 INFO - 'USER': 'cltbld', 09:16:24 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1497882641.372768-1313985863', 09:16:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:24 INFO - '_': '/tools/buildbot/bin/python'} 09:16:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:24 INFO - Downloading/unpacking psutil>=3.1.1 09:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:16:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:16:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:16:25 INFO - Installing collected packages: psutil 09:16:25 INFO - Running setup.py install for psutil 09:16:25 INFO - building 'psutil._psutil_linux' extension 09:16:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:16:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:16:25 INFO - building 'psutil._psutil_posix' extension 09:16:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:16:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:16:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:16:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:16:26 INFO - Successfully installed psutil 09:16:26 INFO - Cleaning up... 09:16:26 INFO - Return code: 0 09:16:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:16:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:26 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 0xb5b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed7140>, '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 0xed7a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed7ed0>, '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': '8783db0840cc980e80bb0bd400000236-1497882641.372768-1313985863', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:16:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:16:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:16:26 INFO - Using env: {'DISPLAY': ':0', 09:16:26 INFO - 'HOME': '/home/cltbld', 09:16:26 INFO - 'LANG': 'en_US.UTF-8', 09:16:26 INFO - 'LANGUAGE': 'en_US:en', 09:16:26 INFO - 'LOGNAME': 'cltbld', 09:16:26 INFO - 'MAIL': '/var/mail/cltbld', 09:16:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:26 INFO - 'MOZ_NO_REMOTE': '1', 09:16:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:26 INFO - 'NO_EM_RESTART': '1', 09:16:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:26 INFO - 'PWD': '/builds/slave/test', 09:16:26 INFO - 'SHELL': '/bin/bash', 09:16:26 INFO - 'SHLVL': '1', 09:16:26 INFO - 'TERM': 'linux', 09:16:26 INFO - 'TMOUT': '86400', 09:16:26 INFO - 'USER': 'cltbld', 09:16:26 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1497882641.372768-1313985863', 09:16:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:26 INFO - '_': '/tools/buildbot/bin/python'} 09:16:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:16:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:16:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:16:27 INFO - Installing collected packages: mozsystemmonitor 09:16:27 INFO - Running setup.py install for mozsystemmonitor 09:16:27 INFO - Successfully installed mozsystemmonitor 09:16:27 INFO - Cleaning up... 09:16:27 INFO - Return code: 0 09:16:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:27 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 0xb5b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed7140>, '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 0xed7a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed7ed0>, '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': '8783db0840cc980e80bb0bd400000236-1497882641.372768-1313985863', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:16:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:16:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:16:27 INFO - Using env: {'DISPLAY': ':0', 09:16:27 INFO - 'HOME': '/home/cltbld', 09:16:27 INFO - 'LANG': 'en_US.UTF-8', 09:16:27 INFO - 'LANGUAGE': 'en_US:en', 09:16:27 INFO - 'LOGNAME': 'cltbld', 09:16:27 INFO - 'MAIL': '/var/mail/cltbld', 09:16:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:27 INFO - 'MOZ_NO_REMOTE': '1', 09:16:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:27 INFO - 'NO_EM_RESTART': '1', 09:16:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:27 INFO - 'PWD': '/builds/slave/test', 09:16:27 INFO - 'SHELL': '/bin/bash', 09:16:27 INFO - 'SHLVL': '1', 09:16:27 INFO - 'TERM': 'linux', 09:16:27 INFO - 'TMOUT': '86400', 09:16:27 INFO - 'USER': 'cltbld', 09:16:27 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1497882641.372768-1313985863', 09:16:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:27 INFO - '_': '/tools/buildbot/bin/python'} 09:16:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:27 INFO - Downloading/unpacking jsonschema==2.5.1 09:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:16:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:29 INFO - Downloading functools32-3.2.3-2.tar.gz 09:16:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:16:29 INFO - warning: no files found matching '*.txt' 09:16:29 INFO - no previously-included directories found matching 'build' 09:16:29 INFO - no previously-included directories found matching 'dist' 09:16:29 INFO - no previously-included directories found matching '.git*' 09:16:29 INFO - Installing collected packages: jsonschema, functools32 09:16:29 INFO - Running setup.py install for functools32 09:16:29 INFO - warning: no files found matching '*.txt' 09:16:29 INFO - no previously-included directories found matching 'build' 09:16:29 INFO - no previously-included directories found matching 'dist' 09:16:29 INFO - no previously-included directories found matching '.git*' 09:16:29 INFO - Successfully installed jsonschema functools32 09:16:29 INFO - Cleaning up... 09:16:29 INFO - Return code: 0 09:16:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:16:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:29 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 0xb5b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed7140>, '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 0xed7a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed7ed0>, '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': '8783db0840cc980e80bb0bd400000236-1497882641.372768-1313985863', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:16:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:16:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:16:29 INFO - Using env: {'DISPLAY': ':0', 09:16:29 INFO - 'HOME': '/home/cltbld', 09:16:29 INFO - 'LANG': 'en_US.UTF-8', 09:16:29 INFO - 'LANGUAGE': 'en_US:en', 09:16:29 INFO - 'LOGNAME': 'cltbld', 09:16:29 INFO - 'MAIL': '/var/mail/cltbld', 09:16:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:29 INFO - 'MOZ_NO_REMOTE': '1', 09:16:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:29 INFO - 'NO_EM_RESTART': '1', 09:16:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:29 INFO - 'PWD': '/builds/slave/test', 09:16:29 INFO - 'SHELL': '/bin/bash', 09:16:29 INFO - 'SHLVL': '1', 09:16:29 INFO - 'TERM': 'linux', 09:16:29 INFO - 'TMOUT': '86400', 09:16:29 INFO - 'USER': 'cltbld', 09:16:29 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1497882641.372768-1313985863', 09:16:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:29 INFO - '_': '/tools/buildbot/bin/python'} 09:16:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:16:29 INFO - Cleaning up... 09:16:29 INFO - Return code: 0 09:16:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:16:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:29 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 0xb5b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed7140>, '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 0xed7a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed7ed0>, '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': '8783db0840cc980e80bb0bd400000236-1497882641.372768-1313985863', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:16:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:16:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:16:29 INFO - Using env: {'DISPLAY': ':0', 09:16:29 INFO - 'HOME': '/home/cltbld', 09:16:29 INFO - 'LANG': 'en_US.UTF-8', 09:16:29 INFO - 'LANGUAGE': 'en_US:en', 09:16:29 INFO - 'LOGNAME': 'cltbld', 09:16:29 INFO - 'MAIL': '/var/mail/cltbld', 09:16:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:29 INFO - 'MOZ_NO_REMOTE': '1', 09:16:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:29 INFO - 'NO_EM_RESTART': '1', 09:16:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:29 INFO - 'PWD': '/builds/slave/test', 09:16:29 INFO - 'SHELL': '/bin/bash', 09:16:29 INFO - 'SHLVL': '1', 09:16:29 INFO - 'TERM': 'linux', 09:16:29 INFO - 'TMOUT': '86400', 09:16:29 INFO - 'USER': 'cltbld', 09:16:29 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1497882641.372768-1313985863', 09:16:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:29 INFO - '_': '/tools/buildbot/bin/python'} 09:16:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:29 INFO - Downloading/unpacking blobuploader==1.2.4 09:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:31 INFO - Downloading blobuploader-1.2.4.tar.gz 09:16:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:16:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:16:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:31 INFO - Downloading docopt-0.6.1.tar.gz 09:16:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:16:31 INFO - Installing collected packages: blobuploader, requests, docopt 09:16:31 INFO - Running setup.py install for blobuploader 09:16:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:16:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:16:31 INFO - Running setup.py install for requests 09:16:32 INFO - Running setup.py install for docopt 09:16:32 INFO - Successfully installed blobuploader requests docopt 09:16:32 INFO - Cleaning up... 09:16:32 INFO - Return code: 0 09:16:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:32 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 0xb5b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed7140>, '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 0xed7a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed7ed0>, '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': '8783db0840cc980e80bb0bd400000236-1497882641.372768-1313985863', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:16:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:16:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:16:32 INFO - Using env: {'DISPLAY': ':0', 09:16:32 INFO - 'HOME': '/home/cltbld', 09:16:32 INFO - 'LANG': 'en_US.UTF-8', 09:16:32 INFO - 'LANGUAGE': 'en_US:en', 09:16:32 INFO - 'LOGNAME': 'cltbld', 09:16:32 INFO - 'MAIL': '/var/mail/cltbld', 09:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:32 INFO - 'MOZ_NO_REMOTE': '1', 09:16:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:32 INFO - 'NO_EM_RESTART': '1', 09:16:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:32 INFO - 'PWD': '/builds/slave/test', 09:16:32 INFO - 'SHELL': '/bin/bash', 09:16:32 INFO - 'SHLVL': '1', 09:16:32 INFO - 'TERM': 'linux', 09:16:32 INFO - 'TMOUT': '86400', 09:16:32 INFO - 'USER': 'cltbld', 09:16:32 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1497882641.372768-1313985863', 09:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:32 INFO - '_': '/tools/buildbot/bin/python'} 09:16:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:16:32 INFO - Running setup.py (path:/tmp/pip-ki6XLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:16:32 INFO - Running setup.py (path:/tmp/pip-jyAlFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:16:32 INFO - Running setup.py (path:/tmp/pip-QfI5r1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:16:32 INFO - Running setup.py (path:/tmp/pip-RbOgYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:16:32 INFO - Running setup.py (path:/tmp/pip-fWS9qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:16:32 INFO - Running setup.py (path:/tmp/pip-12HSOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:16:32 INFO - Running setup.py (path:/tmp/pip-oGnN_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:16:32 INFO - Running setup.py (path:/tmp/pip-A_F8EI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:16:33 INFO - Running setup.py (path:/tmp/pip-dsVcKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:16:33 INFO - Running setup.py (path:/tmp/pip-mpzc1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:16:33 INFO - Running setup.py (path:/tmp/pip-Jty_fi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:16:33 INFO - Running setup.py (path:/tmp/pip-tzShJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:16:33 INFO - Running setup.py (path:/tmp/pip-p06k9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:16:33 INFO - Running setup.py (path:/tmp/pip-Xsxcdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:33 INFO - Running setup.py (path:/tmp/pip-JPaHdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:16:33 INFO - Running setup.py (path:/tmp/pip-bBf83d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:16:33 INFO - Running setup.py (path:/tmp/pip-_USmjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:16:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:16:33 INFO - Running setup.py install for manifestparser 09:16:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:16:33 INFO - Running setup.py install for mozcrash 09:16:33 INFO - Running setup.py install for mozdebug 09:16:33 INFO - Running setup.py install for mozdevice 09:16:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:16:34 INFO - Running setup.py install for mozfile 09:16:34 INFO - Running setup.py install for mozhttpd 09:16:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:16:34 INFO - Running setup.py install for mozinfo 09:16:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:16:34 INFO - Running setup.py install for mozInstall 09:16:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:16:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:16:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:16:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:16:34 INFO - Running setup.py install for mozleak 09:16:34 INFO - Running setup.py install for mozlog 09:16:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:16:34 INFO - Running setup.py install for moznetwork 09:16:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:16:34 INFO - Running setup.py install for mozprocess 09:16:34 INFO - Running setup.py install for mozprofile 09:16:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:16:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:16:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:16:35 INFO - Running setup.py install for mozrunner 09:16:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:16:35 INFO - Running setup.py install for mozscreenshot 09:16:35 INFO - Running setup.py install for moztest 09:16:35 INFO - Running setup.py install for mozversion 09:16:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:16:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:16:35 INFO - Cleaning up... 09:16:35 INFO - Return code: 0 09:16:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:35 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 0xb5b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed7140>, '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 0xed7a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed7ed0>, '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': '8783db0840cc980e80bb0bd400000236-1497882641.372768-1313985863', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:16:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:16:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:16:35 INFO - Using env: {'DISPLAY': ':0', 09:16:35 INFO - 'HOME': '/home/cltbld', 09:16:35 INFO - 'LANG': 'en_US.UTF-8', 09:16:35 INFO - 'LANGUAGE': 'en_US:en', 09:16:35 INFO - 'LOGNAME': 'cltbld', 09:16:35 INFO - 'MAIL': '/var/mail/cltbld', 09:16:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:35 INFO - 'MOZ_NO_REMOTE': '1', 09:16:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:35 INFO - 'NO_EM_RESTART': '1', 09:16:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:35 INFO - 'PWD': '/builds/slave/test', 09:16:35 INFO - 'SHELL': '/bin/bash', 09:16:35 INFO - 'SHLVL': '1', 09:16:35 INFO - 'TERM': 'linux', 09:16:35 INFO - 'TMOUT': '86400', 09:16:35 INFO - 'USER': 'cltbld', 09:16:35 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1497882641.372768-1313985863', 09:16:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:35 INFO - '_': '/tools/buildbot/bin/python'} 09:16:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:16:35 INFO - Running setup.py (path:/tmp/pip-avNrfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:16:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:16:35 INFO - Running setup.py (path:/tmp/pip-Oq7gnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:16:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:16:35 INFO - Running setup.py (path:/tmp/pip-ORmT4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:16:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:16:35 INFO - Running setup.py (path:/tmp/pip-HSzZ7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:16:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:16:36 INFO - Running setup.py (path:/tmp/pip-cBSgsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:16:36 INFO - Running setup.py (path:/tmp/pip-g8h7ZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:16:36 INFO - Running setup.py (path:/tmp/pip-0AbYvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:16:36 INFO - Running setup.py (path:/tmp/pip-hrk8LZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:16:36 INFO - Running setup.py (path:/tmp/pip-rkSeyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:16:36 INFO - Running setup.py (path:/tmp/pip-47kbTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:16:36 INFO - Running setup.py (path:/tmp/pip-MkTMHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:16:36 INFO - Running setup.py (path:/tmp/pip-e6xIQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:16:36 INFO - Running setup.py (path:/tmp/pip-oMAu4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:16:36 INFO - Running setup.py (path:/tmp/pip-pUYXJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:36 INFO - Running setup.py (path:/tmp/pip-nopaQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:16:36 INFO - Running setup.py (path:/tmp/pip-cpR0Ea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:16:36 INFO - Running setup.py (path:/tmp/pip-7NCOv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:16:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:38 INFO - Downloading blessings-1.6.tar.gz 09:16:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:16:38 INFO - Installing collected packages: blessings 09:16:38 INFO - Running setup.py install for blessings 09:16:38 INFO - Successfully installed blessings 09:16:38 INFO - Cleaning up... 09:16:38 INFO - Return code: 0 09:16:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:16:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:16:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:16:38 INFO - Reading from file tmpfile_stdout 09:16:38 INFO - Current package versions: 09:16:38 INFO - argparse == 1.2.1 09:16:38 INFO - blessings == 1.6 09:16:38 INFO - blobuploader == 1.2.4 09:16:38 INFO - docopt == 0.6.1 09:16:38 INFO - functools32 == 3.2.3-2 09:16:38 INFO - jsonschema == 2.5.1 09:16:38 INFO - manifestparser == 1.1 09:16:38 INFO - mozInstall == 1.13 09:16:38 INFO - mozcrash == 1.0 09:16:38 INFO - mozdebug == 0.1 09:16:38 INFO - mozdevice == 0.51 09:16:38 INFO - mozfile == 1.2 09:16:38 INFO - mozhttpd == 0.7 09:16:38 INFO - mozinfo == 0.10 09:16:38 INFO - mozleak == 0.1 09:16:38 INFO - mozlog == 3.4 09:16:38 INFO - moznetwork == 0.27 09:16:38 INFO - mozprocess == 0.25 09:16:38 INFO - mozprofile == 0.28 09:16:38 INFO - mozrunner == 6.13 09:16:38 INFO - mozscreenshot == 0.1 09:16:38 INFO - mozsystemmonitor == 0.3 09:16:38 INFO - moztest == 0.8 09:16:38 INFO - mozversion == 1.4 09:16:38 INFO - psutil == 3.1.1 09:16:38 INFO - requests == 1.2.3 09:16:38 INFO - wsgiref == 0.1.2 09:16:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:38 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 0xb5b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed7140>, '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 0xed7a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed7ed0>, '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': '8783db0840cc980e80bb0bd400000236-1497882641.372768-1313985863', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:16:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:16:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:16:38 INFO - Using env: {'DISPLAY': ':0', 09:16:38 INFO - 'HOME': '/home/cltbld', 09:16:38 INFO - 'LANG': 'en_US.UTF-8', 09:16:38 INFO - 'LANGUAGE': 'en_US:en', 09:16:38 INFO - 'LOGNAME': 'cltbld', 09:16:38 INFO - 'MAIL': '/var/mail/cltbld', 09:16:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:38 INFO - 'MOZ_NO_REMOTE': '1', 09:16:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:38 INFO - 'NO_EM_RESTART': '1', 09:16:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:38 INFO - 'PWD': '/builds/slave/test', 09:16:38 INFO - 'SHELL': '/bin/bash', 09:16:38 INFO - 'SHLVL': '1', 09:16:38 INFO - 'TERM': 'linux', 09:16:38 INFO - 'TMOUT': '86400', 09:16:38 INFO - 'USER': 'cltbld', 09:16:38 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1497882641.372768-1313985863', 09:16:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:38 INFO - '_': '/tools/buildbot/bin/python'} 09:16:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:16:38 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:39 INFO - Downloading marionette_driver-1.4.0.tar.gz 09:16:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 09:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:16:39 INFO - Installing collected packages: marionette-driver 09:16:39 INFO - Running setup.py install for marionette-driver 09:16:39 INFO - Successfully installed marionette-driver 09:16:39 INFO - Cleaning up... 09:16:40 INFO - Return code: 0 09:16:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:16: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')]} 09:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16: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')]} 09:16:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:40 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 0xb5b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed7140>, '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 0xed7a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed7ed0>, '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': '8783db0840cc980e80bb0bd400000236-1497882641.372768-1313985863', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:16:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:16:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:16:40 INFO - Using env: {'DISPLAY': ':0', 09:16:40 INFO - 'HOME': '/home/cltbld', 09:16:40 INFO - 'LANG': 'en_US.UTF-8', 09:16:40 INFO - 'LANGUAGE': 'en_US:en', 09:16:40 INFO - 'LOGNAME': 'cltbld', 09:16:40 INFO - 'MAIL': '/var/mail/cltbld', 09:16:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:40 INFO - 'MOZ_NO_REMOTE': '1', 09:16:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:40 INFO - 'NO_EM_RESTART': '1', 09:16:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:40 INFO - 'PWD': '/builds/slave/test', 09:16:40 INFO - 'SHELL': '/bin/bash', 09:16:40 INFO - 'SHLVL': '1', 09:16:40 INFO - 'TERM': 'linux', 09:16:40 INFO - 'TMOUT': '86400', 09:16:40 INFO - 'USER': 'cltbld', 09:16:40 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1497882641.372768-1313985863', 09:16:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:40 INFO - '_': '/tools/buildbot/bin/python'} 09:16:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:16:40 INFO - Cleaning up... 09:16:40 INFO - Return code: 0 09:16:40 INFO - Running post-action listener: _resource_record_post_action 09:16:40 INFO - Running post-action listener: _start_resource_monitoring 09:16:40 INFO - Starting resource monitoring. 09:16:40 INFO - [mozharness: 2017-06-19 16:16:40.296946Z] Finished create-virtualenv step (success) 09:16:40 INFO - [mozharness: 2017-06-19 16:16:40.297476Z] Running install step. 09:16:40 INFO - Running pre-action listener: _resource_record_pre_action 09:16:40 INFO - Running main action method: install 09:16:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:16:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:16:40 INFO - Reading from file tmpfile_stdout 09:16:40 INFO - Detecting whether we're running mozinstall >=1.0... 09:16:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:16:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:16:40 INFO - Reading from file tmpfile_stdout 09:16:40 INFO - Output received: 09:16:40 INFO - Usage: mozinstall [options] installer 09:16:40 INFO - Options: 09:16:40 INFO - -h, --help show this help message and exit 09:16:40 INFO - -d DEST, --destination=DEST 09:16:40 INFO - Directory to install application into. [default: 09:16:40 INFO - "/builds/slave/test"] 09:16:40 INFO - --app=APP Application being installed. [default: firefox] 09:16:40 INFO - mkdir: /builds/slave/test/build/application 09:16:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:16:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:16:58 INFO - Reading from file tmpfile_stdout 09:16:58 INFO - Output received: 09:16:58 INFO - /builds/slave/test/build/application/firefox/firefox 09:16:58 INFO - Running post-action listener: _resource_record_post_action 09:16:58 INFO - [mozharness: 2017-06-19 16:16:58.009632Z] Finished install step (success) 09:16:58 INFO - [mozharness: 2017-06-19 16:16:58.009907Z] Running setup-mitmproxy step. 09:16:58 INFO - Running pre-action listener: _resource_record_pre_action 09:16:58 INFO - Running main action method: setup_mitmproxy 09:16:58 INFO - Skipping: mitmproxy is not required 09:16:58 INFO - Running post-action listener: _resource_record_post_action 09:16:58 INFO - [mozharness: 2017-06-19 16:16:58.011025Z] Finished setup-mitmproxy step (success) 09:16:58 INFO - [mozharness: 2017-06-19 16:16:58.011258Z] Running run-tests step. 09:16:58 INFO - Running pre-action listener: _resource_record_pre_action 09:16:58 INFO - Running main action method: run_tests 09:16:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:16:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:16:58 INFO - Python 2.7.3 09:16:58 INFO - Return code: 0 09:16:58 INFO - grabbing minidump binary from tooltool 09:16:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:58 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 0xed7140>, '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 0xed7a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed7ed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:16:58 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:16:58 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:16:58 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:16:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:16:58 INFO - Return code: 0 09:16:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:16:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:16:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:16:58 INFO - ENV: RUST_BACKTRACE is now 1 09:16:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:16:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:16:58 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/e2STNDhHQv2F-9vOiEUE3w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:16:58 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/e2STNDhHQv2F-9vOiEUE3w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:16:58 INFO - Using env: {'DISPLAY': ':0', 09:16:58 INFO - 'HOME': '/home/cltbld', 09:16:58 INFO - 'LANG': 'en_US.UTF-8', 09:16:58 INFO - 'LANGUAGE': 'en_US:en', 09:16:58 INFO - 'LOGNAME': 'cltbld', 09:16:58 INFO - 'MAIL': '/var/mail/cltbld', 09:16:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:16:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:16:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:58 INFO - 'MOZ_NO_REMOTE': '1', 09:16:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:16:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:58 INFO - 'NO_EM_RESTART': '1', 09:16:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:58 INFO - 'PWD': '/builds/slave/test', 09:16:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:16:58 INFO - 'RUST_BACKTRACE': '1', 09:16:58 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:16:58 INFO - 'SHELL': '/bin/bash', 09:16:58 INFO - 'SHLVL': '1', 09:16:58 INFO - 'TERM': 'linux', 09:16:58 INFO - 'TMOUT': '86400', 09:16:58 INFO - 'USER': 'cltbld', 09:16:58 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1497882641.372768-1313985863', 09:16:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:58 INFO - '_': '/tools/buildbot/bin/python'} 09:16:58 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/e2STNDhHQv2F-9vOiEUE3w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:16:58 INFO - mozversion application_buildid: 20170619153927 09:16:58 INFO - mozversion application_changeset: 72346a4d6afcc17504f911190dbf470100e879ec 09:16:58 INFO - mozversion application_display_name: Nightly 09:16:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:16:58 INFO - mozversion application_name: Firefox 09:16:58 INFO - mozversion application_remotingname: firefox 09:16:58 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:16:58 INFO - mozversion application_vendor: Mozilla 09:16:58 INFO - mozversion application_version: 56.0a1 09:16:58 INFO - mozversion platform_buildid: 20170619153927 09:16:58 INFO - mozversion platform_changeset: 72346a4d6afcc17504f911190dbf470100e879ec 09:16:58 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:16:58 INFO - mozversion platform_version: 56.0a1 09:16:58 INFO - using testdate: 1497889018 09:16:58 INFO - actual date: 1497889018 09:16:58 INFO - starting webserver on 'localhost:32938' 09:16:58 INFO - SUITE-START | Running 2 tests 09:16:58 INFO - TEST-START | dromaeo_css 09:16:58 INFO - operating with platform_type : linux_ 09:16:58 INFO - Initialising browser for dromaeo_css test... 09:16:58 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:32938/getInfo.html -profile /tmp/tmpX0yn08/profile 09:16:58 INFO - TEST-INFO | started process 17563 (/builds/slave/test/build/application/firefox/firefox http://localhost:32938/getInfo.html) 09:17:05 INFO - TEST-INFO | 17563: exit 0 09:17:06 INFO - Browser initialized. 09:17:06 INFO - Running cycle 1/1 for dromaeo_css test... 09:17:06 INFO - TEST-INFO | started process 17774 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX0yn08/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:17:18 INFO - PID 17774 | RSS: Main: 176123904 09:17:18 INFO - PID 17774 | 09:20:22 INFO - PID 17774 | Cycle 1(1): loaded http://localhost:32938/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32938/tests/dromaeo/cssquery-ext.html) 09:20:24 INFO - PID 17774 | RSS: Main: 181829632 09:20:24 INFO - PID 17774 | 09:23:25 INFO - PID 17774 | Cycle 1(1): loaded http://localhost:32938/tests/dromaeo/cssquery-ext.html (next: http://localhost:32938/tests/dromaeo/cssquery-jquery.html) 09:23:26 INFO - PID 17774 | RSS: Main: 180420608 09:23:26 INFO - PID 17774 | 09:26:27 INFO - PID 17774 | Cycle 1(1): loaded http://localhost:32938/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32938/tests/dromaeo/cssquery-mootools.html) 09:26:28 INFO - PID 17774 | RSS: Main: 183406592 09:26:28 INFO - PID 17774 | 09:29:30 INFO - PID 17774 | Cycle 1(1): loaded http://localhost:32938/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32938/tests/dromaeo/cssquery-prototype.html) 09:29:30 INFO - PID 17774 | RSS: Main: 180776960 09:29:30 INFO - PID 17774 | 09:32:33 INFO - PID 17774 | Cycle 1(1): loaded http://localhost:32938/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32938/tests/dromaeo/cssquery-yui.html) 09:32:34 INFO - PID 17774 | RSS: Main: 181800960 09:32:34 INFO - PID 17774 | 09:35:35 INFO - PID 17774 | Cycle 1(1): loaded http://localhost:32938/tests/dromaeo/cssquery-yui.html (next: http://localhost:32938/tests/dromaeo/cssquery-dojo.html) 09:35:36 INFO - PID 17774 | RSS: Main: 180940800 09:35:36 INFO - PID 17774 | 09:35:36 INFO - PID 17774 | __start_tp_report 09:35:36 INFO - PID 17774 | _x_x_mozilla_page_load 09:35:36 INFO - PID 17774 | _x_x_mozilla_page_load_details 09:35:36 INFO - PID 17774 | |i|pagename|runs| 09:35:36 INFO - PID 17774 | |0;dojo.html;3069.447499450098;3095.644000939892;3119.1578273866057;3125.7655675824317;3139.1524288442115;6091.390860913912;6109.969450152743;6114.875284800365;6129.4810485740945;6159.414855588723;6162.969185154079;6187.75248990041;6193.380661933805;6197.566170368076;6211.254649442062;5678.659280443187;5680.147977803321;5690.06113991191;5707.942920570783;5753.741081651336;5543.057680194356;5613.07384281591;5616.887662246752;5708.315002199742;5708.77164913403;5525.917111243294;5606.299212598426;5653.462921022497;5693.857653558653;5705.030144875381;5684.147377893349;5701.14482827575;5701.914471282934;5723.370429252821;5726.570507211975;5579.0515612346;5633.408492108351;5636.971815140939;5655.915161272585;5657.547396208293;6067.848303792396;6118.20463339763;6137.508999280047;6154.046122850965;6160.815175544741;6453.322401147859;6522.804315870531;6557.278699343116;6563.442107420875;6618.966905165492;6677.198736151693;6705.362990515893;6708.899366509506;6717.865642687118;6722.865542689167;6113;6166.445019948226;6183.628982261079;6189.0097584386285;6194.659293738888;6651;6729.966350168315;6732.394084532318;6736.8989465158065;6765.391114799691;6355.459785918156;6375.852346577568;6496.123023391876;6518.934810651833;6545.476361891037;6580.11168492257;6609.5373323867825;6623.337666233435;6630.403263706289;6666.666666666647;6482.189726284215;6611.471082313404;6634.86730265392;6641.070250164981;6660.833479162963;6547.214334279822;6560.475161987029;6567.408933196035;6617.338266173344;6619.304972977864;5346.064438723286;5371.75827087782;5380.892382152335;5382.730863456812;5412.78348866041;4538.977305113453;4608.193566125915;4622.214223581999;4627.884302892455;4649.418822647169;5865.296164460292;5866.70666466675;5866.794662186803;5882.470577648032;5897.174395584621;6499.740010399626;6665.200175978816;6673.399394054559;6691.866162676719;6719.865602687919;5747.339056008529;5760.222369979999;5761.049426844607;5805.7387417566315;5840.386759390203;5837.09525023622;5837.620554663933;5940.405959404025;5947.1376650385455;5955.880882382328;6468.741250350027;6523;6523.24982626985;6524.4454221389815;6528.445082168069;6725.932740672531;6741.898871516833;6742.9662851685425;6744.527883048139;6756;6292.402221788922;6375.681215939092;6424.582402143846;6425.389587989133;6516.73933042673;6465.353464653497;6495.090687303876;6500.414962653384;6502.902456463252;6512;6708.664566771544;6721.663916804043;6724.4284235840505;6726.226483954408;6734.4612431004425;6450.322716114928;6455.870882582416;6465.676716164079;6468.741250349934;6496.090547323473;6286.465650419766;6403.4877209824035;6413.935860641521;6415.6471394071905;6462.612243265419;6259.311475737574;6311.589746666452;6381;6386.616802991835;6435.549511534147;6455.160829092188;6580.144581204413;6580.901286480611;6588.110605068255;6601.801945941629;6370.140031095742;6370.394812492806;6373.904391434039;6386.137871387489;6394.776182833579 09:35:36 INFO - PID 17774 | |1;ext.html;795.1968511803077;838.9328853691705;866.7876370289279;894.1728900766789;898.7753061734567;39605.60394396059;40218.99999999996;40256;40440.797796011015;40509.59490405095;35906;36171.638283617154;36284.81857590715;36336.45495317572;36347;6751.696173672172;6890.2076261230095;6893.138357705287;6902.689378977958;6915.204751453572;6765.560238584476;6853.897191542131;6872.553284036521;6882.5870447773295;6885.621290829003;6800.523963322569;6833.214180369271;6863.519553631248;6867.278935711754;6897.689603967809;6818.0795592595105;6830.6243156626115;6833.453323734139;6843.931560684404;6851.109355783717;6134.754609815602;6188.96905515474;6193.0710393440895;6198.349173336825;7478.401727861758;36448.63551364505;36515.087122822144;36691.4496282556;36781;36839;3433.8454769535433;3466.1507930556922;3468.289000754839;3473.670001349893;3483.059573915029;29854.552181717292;29897.25256868574;29908.700912991026;29912.756543259344;30111.849440752874;3526.2242306692488;3590.263995880864;3619.2942376236642;3623.655752703515;3658.6158453362546;185380;185952;186080;187905;188319.99999999863;47579.76210118927;48014.759926200844;48407.515924841005;48513.272300915516;48622.75688621534;50296.74851625792;50803.23795143076;50817;50849.23726144111;51090.744546277776;15324.463643772415;15369.615759606098;15419;15452.845471545366;15480.690386192438;12701.809472857914;12718.236905785683;12799.808002879965;12812.679683008;12817;13910.652233694036;13927.791083133761;13957.232352220726;14021.719565608835;14070;5740.483356497935;5765.1928729977835;5770.451807078321;5786.971065144648;5825.854353641108;984.5471083301618;988.3625061835077;999.9950000249952;1024.6516184497307;1024.7591815923251;22370.440738981655;22856.428589285402;22970.851457427063;23073.769262307163;23612.527749444915;1075.6235317638764;1095.3393311459688;1112.404863398078;1117.407773879845;1122.7080958950733;11824.467898944396;11943.462544185533;12157.696057598454;12168.513259469522;12399.820350316919;212416;215016;215258;215319;215376;51789;52014.479855201724;52110;52180.47819521756;52346.73826630843;1426.621945184527;1448.1745405118982;1469.3094245704501;1488.4567132996378;1494.4321157960123;21995.780042199374;22416.551668966855;22433.32700019002;23196;23337.76662233356;36733.26533469262;36967;36993.44509832408;37074;37162;168679.1566042162;169073;169929;170315;170657;30434.239144021576;30883.536746949263;30943.226419339695;32106;32765.672343276263;40567.1886562273;41544.58455415528;42708.35937461003;42989.78505107454;43059.138817222854;29159.85420072886;30107.69892301049;30342;30791.445987808176;31919.444305632274;29843;29892.55161172541;30726.84636576892;31301.8434907824;31633;32870.506942395405;33826.3234735299;34130.48804267888;34340.656593434745;34991.65008349986;28592.71407285984;29284.56073158947;29529.85235073811;30057.54913676253;30519.389612208077;23330.183443579393;24249.878750606134;24456.633150503112;24586.754132459162;24765.25704228876 09:35:36 INFO - PID 17774 | |2;jquery.html;539.4740128374835;555.3641080962295;560.6299842104212;562.7833284185588;578.2973686970331;20483.487912802168;21688.674669879943;21721.456963575918;21794.782052179475;21832;23492.412689682722;24560.508789824195;25819.741802581968;25958.091466798665;26146.215613531578;6447.935520644781;6559.540832141752;6560.179977502812;6568.540202185849;6568.7372505099975;6508.381703738161;6579.309172536887;6581.7696380626685;6587.47300215984;6594.043863639769;5907.350191478934;6379.808605741835;6468.773592924249;6527.347265273482;6544.574602650836;6381.808545743612;6425.06836508706;6442.645654489002;6457.61254324742;6481.708323125495;5993.940060599425;6006.819795406102;6019.097135429677;6020.69896505173;6026.427489388501;27356.45287094247;28229.717702822913;28440.28899277514;28706.712932870614;28765.424691506054;1856.5637075287298;1915.329634627883;1922.1254329280284;1941.2526177421653;1944.4361135270753;17786.199621017084;18211.63576728471;18223.362182323555;18238.08809559517;18301.267949282144;2340.2511196417154;2343.9296821095395;2388.044782087162;2390.988045059781;2427.8057755379705;122320;127601.36199319037;127798.3610081953;128478;128883.35558322242;13466.124701894345;14471.204083775494;14566.4901728439;14744.778828317583;15156.968606278788;23217.651735223986;23286.767132328798;23321.7667823323;23323.300300991;23330.533389332457;9732.367396119229;9870.901290987142;9955.402675839472;10037.598496060076;10106.949465252774;9131.178193962442;9186.81626367469;9188.95405522968;9210.63157473707;9278.72163835086;8974.596143173572;9005.14451127142;9093.954195267628;9176.17414432691;9179.265658747285;2610.1777939948856;2638.60420936861;2706.120510833987;2781.206122051306;2821.4357128574366;967.9564419601135;986.2603047714215;988.3625061835077;1009.3439264478149;1014.4116412480892;19226.230950762092;19390.903045484683;20006.099725512388;20023.799762002192;20210.494737631678;993.5429702336861;1023.902729240721;1036.2228328753436;1050.3172937590627;1059.0944742245424;10670.51982660782;10897.564097436014;11013.339199648046;11289.322640641587;12469.563565275172;521365;539666;550764;554126;554526;111263;112042.43978780054;113430.43284783523;114823.42588287173;114840;1201.741625550511;1242.3105176626877;1263.109507797001;1268.422867595242;1275.9362031898554;18862.811371886106;20701.27545535899;20728.17087316551;20886;20965.266215682987;49495.50504494909;53230.46769532255;54024;54689.453105468434;54847.45152548583;65910.67044664746;66657;67117.32882671306;67240;67788.3221167782;12618.55835045769;12683.682907927376;12743.044271679846;12784.808227876776;12827.679308017001;17902.194401251716;18773.155208015945;18817.247310107443;18921.243150273836;19073.237070517578;14762.188079655722;15456.690866182389;15532.534023979299;15563.221838908235;15568.844311556739;13533.932330338286;13779.311034448037;13816.516421925184;13911.721765564835;14176.220307883166;15719.68560628804;15800.683986320439;15879.52361429159;16030.67938641244;16045.19774011318;11809.173357864867;12448.377581120727;12567;12569.183003104768;12600.873991260336;15284.77072843886;15420;15420.537383878502;15494.922525387301;15808 09:35:36 INFO - PID 17774 | |3;mootools.html;1350.8851747601454;1413.4982081361115;1415.18626789596;1417.6172433442978;1428.2929949674908;12439.315837628927;13038.73922521549;13057.412416441259;13091.345432728362;13095.607131786062;12573.685657858558;12929.612111636643;12932.22406655599;12943.417546210443;12989.350532473361;2311.6185829338183;2341.344423561397;2365.254944692425;2367.5856725073045;2378.298401971414;2003.0986056274662;2034.6541088015074;2035.3385149826292;2047.7440319960006;2048.5185981294385;2138.8502804803593;2171.381156370435;2183.061283648031;2184.770599087097;2194.188150384352;2216.213244298267;2224.8887555622237;2237.362351729749;2246.898889549966;2247.2808701215536;2174.282486779359;2259.175400978631;2270.2848602690265;2282.6804247405375;2293.6559516072557;13015.804762928563;13089;13143.27711975841;13177.341132943315;13188.934055329757;7016.193137789169;7310.671019804122;7322.1579518355;7343.559386436831;7350.044494215717;4114;4234.06850492891;4313.892152696177;4316.784160791979;4362.1275744851155;1451.4049239811732;1490.5975386645546;1503.9097654140787;1561.2505997121332;1584.5167223996677;18204.36284730028;18845.90577047106;19775.110120044632;19793.505162371057;20029.899850500653;5424.945750542523;5583.609147359646;5858.765649373977;6075.544334174954;6100.69496525172;14312.928435357964;14334.928325358307;14346.641333966525;14404.855951440351;14418.783718244234;6875.312468753084;6898.827529311808;6918.8962165567555;6924.480663950224;6925.376716095576;6408.711607977652;6547.247066587308;6608.140941677551;6632.834179145463;6645.401913827779;4127.215828992482;4243.087736136746;4267.786610669516;4363.759993200404;4367.388565600819;1325.7613629546775;1337.9331033448289;1348.110247236819;1352.7700290950365;1374.0793668242302;911.8951320598217;922.9169374756304;924.4453328003278;946.9857952130724;962.7208109648124;7304.160021597478;7427.888581671279;7995.760127196193;8559.315254779603;8600.354973377021;1006.6979906028308;1020.811149937264;1023.7747695506977;1025.5692609104194;1041.1878734587035;4983.900321993612;5142.9742851286255;5426.620136590401;5513.09034009384;5687.175359572839;17014.744778828328;17456.563585910455;17618.82381176172;17637.294508219784;17647.911760441115;17057.744133838;17285.740713889303;17361.913190433967;17405;17571.824281757275;9724.513774311255;10060.949695251476;10228.948855255825;10238.18094552434;10315.432651204255;7713.730019449293;7739.264769846855;8202.507849529047;8254.958725206576;8599;14354.569362919128;14357.856421435652;14976.326065326868;14983.550493485212;15026.849731502545;13681.384337704629;15087;15257.237138143271;15342.232888355315;15409.075455472708;10500.264981451224;10625.9468702656;10710.839337409789;10720;10735.141188705042;11397.886021140013;11422.771544568895;11802.704932376759;12427.813582796085;12429.627111186679;9711.465869376969;10348.120409764953;10361.326513776581;10451.111655509063;10540.10409115203;9605.135537801352;9853.556589953612;10200.183985281308;10343.94828025855;10478.266521343432;9191.448513089235;9222.40054396462;9244.491552964651;9275.76810579741;9309.906900931175;6402.487800976004;6562.901556476561;6950.165980082423;6953.930460695328;6989.475789315923;6786.355296246848;7045.436365090883;7225.458090643117;7314.4148468123485;7385.667644956097 09:35:36 INFO - PID 17774 | |4;prototype.html;478.8036904869002;491.5060364333844;506.071359056132;510.14550627698594;513.1430511046552;6324.715387807548;6413.262474815398;6423.357664233575;6431.871362572751;6478.125453063835;6144.692765361725;6296.433321001109;6300.960341543651;6323.494120470363;6327.905081423783;5063.392392912856;5074.340335756356;5078.771455284503;5085.160948443521;5105.4128775190775;5072.771725272371;5096.821611243608;5097.745112744366;5119.744012799364;5162.199859021857;5067;5071.492850714917;5079.873003174932;5094.77073531692;5104.64267501275;4885.340479035338;5048.747562621891;5063.974680126613;5077.49225077493;5089.312942752718;4506.752128632924;4506.977465112654;4512.86461406155;4518.277075667877;4547.090581883604;6168.383161683841;6186.56694031418;6207.596506227081;6217.222847144107;6222.875542489125;5769.971150144264;5813.43037379905;5821.18503409523;5828.854278643068;5846.795362162304;6756.729730810762;6761.222459417181;6774;6785.457163426963;6791;4917.483664215241;4934.383202099738;4941.665750247449;4942.728149951751;4960.553550180501;7044.788656340318;7108.715651373939;7149.571025738473;7155.141383034017;7171.426285897168;5043.949560504348;5070.6957582545165;5074.82238121664;5084.703400632889;5089.244210747286;5142.04872098663;5145.665531740425;5146.253793199965;5146.845594632167;5147.356580427447;5810.7628563003545;5814.360420353758;5817.894600025981;5842.415758424124;5844.240248767633;6816.931830681729;6841.2132604750095;6850.2598960416235;6853.931460685429;6862.656867156622;1666.7666526686273;1755.7709603277756;1764.5765016395972;1770.822917708219;1777.8399944005102;1196.5692350753723;1197.9580714674944;1211.0372254058045;1231.8213858990575;1231.8644949055597;5754.625949313365;5875;5894.734736936848;5959.106134079922;5962.522998160137;6781.220159681699;6922.546265284246;6935.618540980295;6963.9303606964295;6968.547044442095;5839.2992840858515;5872.324682661463;5905.911411328833;5907.409259074144;5961.225040744762;3627.9637203628154;3642.1987162824134;3650.9817450913106;3660.670539651444;3676.4485327201132;6620.602763834186;6620.635865027373;6621.602703837785;6657.866842663217;6675.7997260082275;7040.084788977502;7048.259932707095;7060.470464715167;7082.256363081905;7088.149422069385;6637.767678131146;6647.700853461509;6648.135742353463;6680.83297917556;6691.297413771581;6746.932530674827;6824.839777237782;6834.624095674786;6846.623435711083;6861.965690171517;6725.159355080615;6769.092408004158;6791.286914873867;6792.962111366669;6815.727370905108;6269.655168965568;6566.671666416564;6649.235337936199;6670.731951136637;6696.966515167393;4875.268709693574;4986.526280003394;5002.574781143643;5027;5082.669626474268;6916.723331066701;6919.550229235084;6931.965340173267;6971;6991.650417479004;6664.4668426524795;6676.966615167087;6687.498437617295;6695.330466953265;6696.899546506904;6616.4045235929;6656.434203092597;6712.429443497357;6727.26000139994;6737.629430381376;6565.343465653396;6584.934150658623;6629.270780214076;6664.435531002056;6677.899831502628;6711.349017138301;6769.28922463154;6806.7957961261245;6809.93190068093;6827.224921520341;6522.869542609216;6572;6601.900971485527;6607.834804129935;6610.206775187008 09:35:36 INFO - PID 17774 | |5;yui.html;828.2793969246757;830.2735106781566;842.886210361601;877.0527829943661;894.977625559361;17290.91354543227;17386.565335866595;17700.203490842912;17706.20322085506;17880.37418690346;15764.684706305867;15856.28646710898;17341.826581734178;18019.63960720785;19101;1022.4580972084807;1058.91528677706;1069.9732506687317;1070.288258308228;1074.3231763988676;1068.7274744940069;1082.5940272397852;1089.4933855757072;1091.7761858818963;1092.049916572583;1125.139268459629;1125.4372813593204;1135.9602413915516;1137.1244142010646;1137.852079229699;1053.7629033467485;1082.1883587309517;1105.8562386889732;1119.0599896087285;1122.4724379541603;792.374024520628;808.640155130967;811.0227176252602;811.217175425717;813.3005615170948;18249.17878695462;18377.816221837744;18521.444356669323;18537.35119270819;18618.813811861844;19003.144858481402;19469.902650486798;19571.608567828705;19655.115519801642;19696.704549431626;14724.19016954067;14917.925410372987;14992;15053.5483935481;15139.091654500766;3396.677315655009;3423.8972830815114;3425.1094715373933;3426.43463828468;3431.7940923544666;96103.51948240215;98388.50805745997;99100;100206;101400.49299753527;15809.446669366516;15835;16209.756853647204;16212.837871621368;16227.107509087113;26459.73540264611;28010.5798413024;28140.155795326173;28458.288542786595;28630.427391452053;8458.830823383498;8471.576421178916;8658.307335413152;8775.780605484786;8879.200871921557;4082.101937573729;4133.379993001074;4144.48193975753;4153.314703074019;4171.436856024458;4816.325714399987;4888.095702295087;4941.382327209099;4988.80044798204;4990.5508504234795;1001.2240513601871;1019.3934608907688;1026.2918586175515;1033.7984093101923;1034.0383443397561;694.2155364438153;700.8913618389158;705.368695017956;707.5542408282749;725.4269127389409;11679.883201167879;11954.983826374855;12205.572804951784;12942.352882355844;13335.466581336637;698.3400686351349;717.5551158281794;741.0288632238221;748.135903031999;748.8015675845905;4955.306257124005;4986.326845875833;5185.403678577012;5536.363318218457;5553.861153471114;93376.06623933809;93861.5306923461;94771;97332.51333743427;100554.49722751339;62803;82236;84384.57807711045;86210.56894715612;88110.55944720235;64994;71596.28403716;73162.63418682979;74219.62890185622;74775;12019.67783543827;12246.203996740183;12357.75284494287;12623.431945562288;12766.68083297925;32283.716283716283;32423.83788081139;34512.48231276483;34799.47800783041;34891.65108348884;57867;61090;63444;63686;64032.67983660052;17030.403935862185;17906.820931790517;18269;18290.81709182891;18322.81677183211;20564;20823.271185508434;21129;21137.682934755685;21390.679139813226;17173.398931037354;18732.719009215147;19097.236110555423;19175.137118829407;19303.613927721646;18216.726749099038;18729.250829966648;18790.812091878906;19569.315073972342;19811.603767924847;17712.202950866984;17899.910500447415;18000.90999544994;18049.909750451163;18980.810191897905;12145.210561313486;12828.20405143262;13108;13666;13771.242581658105;13205.405756740778;14592.489262875748;14955.626109347353;14997.550073497812;15388.38446462129 09:35:36 INFO - PID 17774 | __end_tp_report 09:35:36 INFO - PID 17774 | __start_cc_report 09:35:36 INFO - PID 17774 | _x_x_mozilla_cycle_collect,359 09:35:36 INFO - PID 17774 | __end_cc_report 09:35:36 INFO - PID 17774 | __startTimestamp1497890136159__endTimestamp 09:35:36 INFO - PID 17774 | 09:35:36 INFO - PID 17774 | ------- Summary: start ------- 09:35:36 INFO - PID 17774 | Number of tests: 6 09:35:36 INFO - PID 17774 | 09:35:36 INFO - PID 17774 | [#0] dojo.html Cycles:165 Average:6106.59 Median:6373.90 stddev:716.71 (11.2%) stddev-sans-first:678.15 09:35:36 INFO - PID 17774 | Values: 3069.4 3095.6 3119.2 3125.8 3139.2 6091.4 6110.0 6114.9 6129.5 6159.4 6163.0 6187.8 6193.4 6197.6 6211.3 5678.7 5680.1 5690.1 5707.9 5753.7 5543.1 5613.1 5616.9 5708.3 5708.8 5525.9 5606.3 5653.5 5693.9 5705.0 5684.1 5701.1 5701.9 5723.4 5726.6 5579.1 5633.4 5637.0 5655.9 5657.5 6067.8 6118.2 6137.5 6154.0 6160.8 6453.3 6522.8 6557.3 6563.4 6619.0 6677.2 6705.4 6708.9 6717.9 6722.9 6113.0 6166.4 6183.6 6189.0 6194.7 6651.0 6730.0 6732.4 6736.9 6765.4 6355.5 6375.9 6496.1 6518.9 6545.5 6580.1 6609.5 6623.3 6630.4 6666.7 6482.2 6611.5 6634.9 6641.1 6660.8 6547.2 6560.5 6567.4 6617.3 6619.3 5346.1 5371.8 5380.9 5382.7 5412.8 4539.0 4608.2 4622.2 4627.9 4649.4 5865.3 5866.7 5866.8 5882.5 5897.2 6499.7 6665.2 6673.4 6691.9 6719.9 5747.3 5760.2 5761.0 5805.7 5840.4 5837.1 5837.6 5940.4 5947.1 5955.9 6468.7 6523.0 6523.2 6524.4 6528.4 6725.9 6741.9 6743.0 6744.5 6756.0 6292.4 6375.7 6424.6 6425.4 6516.7 6465.4 6495.1 6500.4 6502.9 6512.0 6708.7 6721.7 6724.4 6726.2 6734.5 6450.3 6455.9 6465.7 6468.7 6496.1 6286.5 6403.5 6413.9 6415.6 6462.6 6259.3 6311.6 6381.0 6386.6 6435.5 6455.2 6580.1 6580.9 6588.1 6601.8 6370.1 6370.4 6373.9 6386.1 6394.8 09:35:36 INFO - PID 17774 | 09:35:36 INFO - PID 17774 | [#1] ext.html Cycles:180 Average:35441.75 Median:18887.25 stddev:49590.13 (262.6%) stddev-sans-first:49661.00 09:35:36 INFO - PID 17774 | Values: 795.2 838.9 866.8 894.2 898.8 39605.6 40219.0 40256.0 40440.8 40509.6 35906.0 36171.6 36284.8 36336.5 36347.0 6751.7 6890.2 6893.1 6902.7 6915.2 6765.6 6853.9 6872.6 6882.6 6885.6 6800.5 6833.2 6863.5 6867.3 6897.7 6818.1 6830.6 6833.5 6843.9 6851.1 6134.8 6189.0 6193.1 6198.3 7478.4 36448.6 36515.1 36691.4 36781.0 36839.0 3433.8 3466.2 3468.3 3473.7 3483.1 29854.6 29897.3 29908.7 29912.8 30111.8 3526.2 3590.3 3619.3 3623.7 3658.6 185380.0 185952.0 186080.0 187905.0 188320.0 47579.8 48014.8 48407.5 48513.3 48622.8 50296.7 50803.2 50817.0 50849.2 51090.7 15324.5 15369.6 15419.0 15452.8 15480.7 12701.8 12718.2 12799.8 12812.7 12817.0 13910.7 13927.8 13957.2 14021.7 14070.0 5740.5 5765.2 5770.5 5787.0 5825.9 984.5 988.4 1000.0 1024.7 1024.8 22370.4 22856.4 22970.9 23073.8 23612.5 1075.6 1095.3 1112.4 1117.4 1122.7 11824.5 11943.5 12157.7 12168.5 12399.8 212416.0 215016.0 215258.0 215319.0 215376.0 51789.0 52014.5 52110.0 52180.5 52346.7 1426.6 1448.2 1469.3 1488.5 1494.4 21995.8 22416.6 22433.3 23196.0 23337.8 36733.3 36967.0 36993.4 37074.0 37162.0 168679.2 169073.0 169929.0 170315.0 170657.0 30434.2 30883.5 30943.2 32106.0 32765.7 40567.2 41544.6 42708.4 42989.8 43059.1 29159.9 30107.7 30342.0 30791.4 31919.4 29843.0 29892.6 30726.8 31301.8 31633.0 32870.5 33826.3 34130.5 34340.7 34991.7 28592.7 29284.6 29529.9 30057.5 30519.4 23330.2 24249.9 24456.6 24586.8 24765.3 09:35:36 INFO - PID 17774 | 09:35:36 INFO - PID 17774 | [#2] jquery.html Cycles:180 Average:35066.83 Median:21758.12 stddev:90654.58 (416.6%) stddev-sans-first:90871.82 09:35:36 INFO - PID 17774 | Values: 539.5 555.4 560.6 562.8 578.3 20483.5 21688.7 21721.5 21794.8 21832.0 23492.4 24560.5 25819.7 25958.1 26146.2 6447.9 6559.5 6560.2 6568.5 6568.7 6508.4 6579.3 6581.8 6587.5 6594.0 5907.4 6379.8 6468.8 6527.3 6544.6 6381.8 6425.1 6442.6 6457.6 6481.7 5993.9 6006.8 6019.1 6020.7 6026.4 27356.5 28229.7 28440.3 28706.7 28765.4 1856.6 1915.3 1922.1 1941.3 1944.4 17786.2 18211.6 18223.4 18238.1 18301.3 2340.3 2343.9 2388.0 2391.0 2427.8 122320.0 127601.4 127798.4 128478.0 128883.4 13466.1 14471.2 14566.5 14744.8 15157.0 23217.7 23286.8 23321.8 23323.3 23330.5 9732.4 9870.9 9955.4 10037.6 10106.9 9131.2 9186.8 9189.0 9210.6 9278.7 8974.6 9005.1 9094.0 9176.2 9179.3 2610.2 2638.6 2706.1 2781.2 2821.4 968.0 986.3 988.4 1009.3 1014.4 19226.2 19390.9 20006.1 20023.8 20210.5 993.5 1023.9 1036.2 1050.3 1059.1 10670.5 10897.6 11013.3 11289.3 12469.6 521365.0 539666.0 550764.0 554126.0 554526.0 111263.0 112042.4 113430.4 114823.4 114840.0 1201.7 1242.3 1263.1 1268.4 1275.9 18862.8 20701.3 20728.2 20886.0 20965.3 49495.5 53230.5 54024.0 54689.5 54847.5 65910.7 66657.0 67117.3 67240.0 67788.3 12618.6 12683.7 12743.0 12784.8 12827.7 17902.2 18773.2 18817.2 18921.2 19073.2 14762.2 15456.7 15532.5 15563.2 15568.8 13533.9 13779.3 13816.5 13911.7 14176.2 15719.7 15800.7 15879.5 16030.7 16045.2 11809.2 12448.4 12567.0 12569.2 12600.9 15284.8 15420.0 15420.5 15494.9 15808.0 09:35:36 INFO - PID 17774 | 09:35:36 INFO - PID 17774 | [#3] mootools.html Cycles:180 Average:7976.85 Median:2093.68 stddev:5274.31 (251.9%) stddev-sans-first:5265.61 09:35:36 INFO - PID 17774 | Values: 1350.9 1413.5 1415.2 1417.6 1428.3 12439.3 13038.7 13057.4 13091.3 13095.6 12573.7 12929.6 12932.2 12943.4 12989.4 2311.6 2341.3 2365.3 2367.6 2378.3 2003.1 2034.7 2035.3 2047.7 2048.5 2138.9 2171.4 2183.1 2184.8 2194.2 2216.2 2224.9 2237.4 2246.9 2247.3 2174.3 2259.2 2270.3 2282.7 2293.7 13015.8 13089.0 13143.3 13177.3 13188.9 7016.2 7310.7 7322.2 7343.6 7350.0 4114.0 4234.1 4313.9 4316.8 4362.1 1451.4 1490.6 1503.9 1561.3 1584.5 18204.4 18845.9 19775.1 19793.5 20029.9 5424.9 5583.6 5858.8 6075.5 6100.7 14312.9 14334.9 14346.6 14404.9 14418.8 6875.3 6898.8 6918.9 6924.5 6925.4 6408.7 6547.2 6608.1 6632.8 6645.4 4127.2 4243.1 4267.8 4363.8 4367.4 1325.8 1337.9 1348.1 1352.8 1374.1 911.9 922.9 924.4 947.0 962.7 7304.2 7427.9 7995.8 8559.3 8600.4 1006.7 1020.8 1023.8 1025.6 1041.2 4983.9 5143.0 5426.6 5513.1 5687.2 17014.7 17456.6 17618.8 17637.3 17647.9 17057.7 17285.7 17361.9 17405.0 17571.8 9724.5 10060.9 10228.9 10238.2 10315.4 7713.7 7739.3 8202.5 8255.0 8599.0 14354.6 14357.9 14976.3 14983.6 15026.8 13681.4 15087.0 15257.2 15342.2 15409.1 10500.3 10625.9 10710.8 10720.0 10735.1 11397.9 11422.8 11802.7 12427.8 12429.6 9711.5 10348.1 10361.3 10451.1 10540.1 9605.1 9853.6 10200.2 10343.9 10478.3 9191.4 9222.4 9244.5 9275.8 9309.9 6402.5 6562.9 6950.2 6953.9 6989.5 6786.4 7045.4 7225.5 7314.4 7385.7 09:35:36 INFO - PID 17774 | 09:35:36 INFO - PID 17774 | [#4] prototype.html Cycles:180 Average:5636.71 Median:6246.27 stddev:1602.89 (25.7%) stddev-sans-first:1559.93 09:35:36 INFO - PID 17774 | Values: 478.8 491.5 506.1 510.1 513.1 6324.7 6413.3 6423.4 6431.9 6478.1 6144.7 6296.4 6301.0 6323.5 6327.9 5063.4 5074.3 5078.8 5085.2 5105.4 5072.8 5096.8 5097.7 5119.7 5162.2 5067.0 5071.5 5079.9 5094.8 5104.6 4885.3 5048.7 5064.0 5077.5 5089.3 4506.8 4507.0 4512.9 4518.3 4547.1 6168.4 6186.6 6207.6 6217.2 6222.9 5770.0 5813.4 5821.2 5828.9 5846.8 6756.7 6761.2 6774.0 6785.5 6791.0 4917.5 4934.4 4941.7 4942.7 4960.6 7044.8 7108.7 7149.6 7155.1 7171.4 5043.9 5070.7 5074.8 5084.7 5089.2 5142.0 5145.7 5146.3 5146.8 5147.4 5810.8 5814.4 5817.9 5842.4 5844.2 6816.9 6841.2 6850.3 6853.9 6862.7 1666.8 1755.8 1764.6 1770.8 1777.8 1196.6 1198.0 1211.0 1231.8 1231.9 5754.6 5875.0 5894.7 5959.1 5962.5 6781.2 6922.5 6935.6 6963.9 6968.5 5839.3 5872.3 5905.9 5907.4 5961.2 3628.0 3642.2 3651.0 3660.7 3676.4 6620.6 6620.6 6621.6 6657.9 6675.8 7040.1 7048.3 7060.5 7082.3 7088.1 6637.8 6647.7 6648.1 6680.8 6691.3 6746.9 6824.8 6834.6 6846.6 6862.0 6725.2 6769.1 6791.3 6793.0 6815.7 6269.7 6566.7 6649.2 6670.7 6697.0 4875.3 4986.5 5002.6 5027.0 5082.7 6916.7 6919.6 6932.0 6971.0 6991.7 6664.5 6677.0 6687.5 6695.3 6696.9 6616.4 6656.4 6712.4 6727.3 6737.6 6565.3 6584.9 6629.3 6664.4 6677.9 6711.3 6769.3 6806.8 6809.9 6827.2 6522.9 6572.0 6601.9 6607.8 6610.2 09:35:36 INFO - PID 17774 | 09:35:36 INFO - PID 17774 | [#5] yui.html Cycles:180 Average:21035.76 Median:19239.38 stddev:26487.56 (137.7%) stddev-sans-first:26518.40 09:35:36 INFO - PID 17774 | Values: 828.3 830.3 842.9 877.1 895.0 17290.9 17386.6 17700.2 17706.2 17880.4 15764.7 15856.3 17341.8 18019.6 19101.0 1022.5 1058.9 1070.0 1070.3 1074.3 1068.7 1082.6 1089.5 1091.8 1092.0 1125.1 1125.4 1136.0 1137.1 1137.9 1053.8 1082.2 1105.9 1119.1 1122.5 792.4 808.6 811.0 811.2 813.3 18249.2 18377.8 18521.4 18537.4 18618.8 19003.1 19469.9 19571.6 19655.1 19696.7 14724.2 14917.9 14992.0 15053.5 15139.1 3396.7 3423.9 3425.1 3426.4 3431.8 96103.5 98388.5 99100.0 100206.0 101400.5 15809.4 15835.0 16209.8 16212.8 16227.1 26459.7 28010.6 28140.2 28458.3 28630.4 8458.8 8471.6 8658.3 8775.8 8879.2 4082.1 4133.4 4144.5 4153.3 4171.4 4816.3 4888.1 4941.4 4988.8 4990.6 1001.2 1019.4 1026.3 1033.8 1034.0 694.2 700.9 705.4 707.6 725.4 11679.9 11955.0 12205.6 12942.4 13335.5 698.3 717.6 741.0 748.1 748.8 4955.3 4986.3 5185.4 5536.4 5553.9 93376.1 93861.5 94771.0 97332.5 100554.5 62803.0 82236.0 84384.6 86210.6 88110.6 64994.0 71596.3 73162.6 74219.6 74775.0 12019.7 12246.2 12357.8 12623.4 12766.7 32283.7 32423.8 34512.5 34799.5 34891.7 57867.0 61090.0 63444.0 63686.0 64032.7 17030.4 17906.8 18269.0 18290.8 18322.8 20564.0 20823.3 21129.0 21137.7 21390.7 17173.4 18732.7 19097.2 19175.1 19303.6 18216.7 18729.3 18790.8 19569.3 19811.6 17712.2 17899.9 18000.9 18049.9 18980.8 12145.2 12828.2 13108.0 13666.0 13771.2 13205.4 14592.5 14955.6 14997.6 15388.4 09:35:36 INFO - PID 17774 | -------- Summary: end -------- 09:35:36 INFO - PID 17774 | 09:35:36 INFO - TEST-INFO | 17774: exit 0 09:35:36 INFO - TEST-OK | dromaeo_css | took 1118493ms 09:35:36 INFO - TEST-START | kraken 09:35:36 INFO - operating with platform_type : linux_ 09:35:36 INFO - Initialising browser for kraken test... 09:35:36 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:32938/getInfo.html -profile /tmp/tmpPv9cQk/profile 09:35:36 INFO - TEST-INFO | started process 18176 (/builds/slave/test/build/application/firefox/firefox http://localhost:32938/getInfo.html) 09:35:43 INFO - TEST-INFO | 18176: exit 0 09:35:43 INFO - Browser initialized. 09:35:43 INFO - Running cycle 1/1 for kraken test... 09:35:43 INFO - TEST-INFO | started process 18385 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPv9cQk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:35:55 INFO - PID 18385 | RSS: Main: 175861760 09:35:55 INFO - PID 18385 | 09:35:57 INFO - PID 18385 | Cycle 1(1): loaded http://localhost:32938/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32938/tests/kraken/driver.html?testName=audio-beat-detection) 09:35:58 INFO - PID 18385 | RSS: Main: 178974720 09:35:58 INFO - PID 18385 | 09:36:01 INFO - PID 18385 | Cycle 1(1): loaded http://localhost:32938/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32938/tests/kraken/driver.html?testName=audio-dft) 09:36:02 INFO - PID 18385 | RSS: Main: 178683904 09:36:02 INFO - PID 18385 | 09:36:05 INFO - PID 18385 | Cycle 1(1): loaded http://localhost:32938/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32938/tests/kraken/driver.html?testName=audio-fft) 09:36:05 INFO - PID 18385 | RSS: Main: 175734784 09:36:05 INFO - PID 18385 | 09:36:07 INFO - PID 18385 | Cycle 1(1): loaded http://localhost:32938/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32938/tests/kraken/driver.html?testName=audio-oscillator) 09:36:08 INFO - PID 18385 | RSS: Main: 176414720 09:36:08 INFO - PID 18385 | 09:36:10 INFO - PID 18385 | Cycle 1(1): loaded http://localhost:32938/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32938/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:36:11 INFO - PID 18385 | RSS: Main: 176418816 09:36:11 INFO - PID 18385 | 09:36:14 INFO - PID 18385 | Cycle 1(1): loaded http://localhost:32938/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32938/tests/kraken/driver.html?testName=imaging-darkroom) 09:36:14 INFO - PID 18385 | RSS: Main: 180367360 09:36:14 INFO - PID 18385 | 09:36:18 INFO - PID 18385 | Cycle 1(1): loaded http://localhost:32938/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32938/tests/kraken/driver.html?testName=imaging-desaturate) 09:36:18 INFO - PID 18385 | RSS: Main: 182067200 09:36:18 INFO - PID 18385 | 09:36:21 INFO - PID 18385 | Cycle 1(1): loaded http://localhost:32938/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32938/tests/kraken/driver.html?testName=json-parse-financial) 09:36:22 INFO - PID 18385 | RSS: Main: 181280768 09:36:22 INFO - PID 18385 | 09:36:23 INFO - PID 18385 | Cycle 1(1): loaded http://localhost:32938/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32938/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:36:24 INFO - PID 18385 | RSS: Main: 180727808 09:36:24 INFO - PID 18385 | 09:36:26 INFO - PID 18385 | Cycle 1(1): loaded http://localhost:32938/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32938/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:36:26 INFO - PID 18385 | RSS: Main: 181227520 09:36:26 INFO - PID 18385 | 09:36:28 INFO - PID 18385 | Cycle 1(1): loaded http://localhost:32938/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32938/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:36:29 INFO - PID 18385 | RSS: Main: 180305920 09:36:29 INFO - PID 18385 | 09:36:32 INFO - PID 18385 | Cycle 1(1): loaded http://localhost:32938/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32938/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:36:33 INFO - PID 18385 | RSS: Main: 180355072 09:36:33 INFO - PID 18385 | 09:36:36 INFO - PID 18385 | Cycle 1(1): loaded http://localhost:32938/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32938/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:36:36 INFO - PID 18385 | RSS: Main: 179974144 09:36:36 INFO - PID 18385 | 09:36:38 INFO - PID 18385 | Cycle 1(1): loaded http://localhost:32938/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32938/tests/kraken/driver.html?testName=ai-astar) 09:36:38 INFO - PID 18385 | RSS: Main: 181981184 09:36:38 INFO - PID 18385 | 09:36:38 INFO - PID 18385 | __start_tp_report 09:36:38 INFO - PID 18385 | _x_x_mozilla_page_load 09:36:38 INFO - PID 18385 | _x_x_mozilla_page_load_details 09:36:38 INFO - PID 18385 | |i|pagename|runs| 09:36:38 INFO - PID 18385 | |0;ai-astar;102;108;108;107;113;107;111;108;108;108 09:36:38 INFO - PID 18385 | |1;audio-beat-detection;151;124;151;181;128;162;156;122;185;121 09:36:38 INFO - PID 18385 | |2;audio-dft;166;167;162;162;164;173;171;167;163;164 09:36:38 INFO - PID 18385 | |3;audio-fft;76;75;75;172;79;74;75;77;93;75 09:36:38 INFO - PID 18385 | |4;audio-oscillator;82;81;139;82;84;83;136;84;83;135 09:36:38 INFO - PID 18385 | |5;imaging-gaussian-blur;114;114;114;114;114;114;114;114;116;115 09:36:38 INFO - PID 18385 | |6;imaging-darkroom;151;150;150;150;152;151;151;150;149;151 09:36:38 INFO - PID 18385 | |7;imaging-desaturate;95;94;94;94;95;94;94;95;94;94 09:36:38 INFO - PID 18385 | |8;json-parse-financial;56;53;53;56;54;53;59;55;53;56 09:36:38 INFO - PID 18385 | |9;json-stringify-tinderbox;53;54;54;54;54;54;59;59;55;53 09:36:38 INFO - PID 18385 | |10;stanford-crypto-aes;78;89;77;78;78;86;78;77;77;76 09:36:38 INFO - PID 18385 | |11;stanford-crypto-ccm;136;141;141;132;126;140;134;142;129;145 09:36:38 INFO - PID 18385 | |12;stanford-crypto-pbkdf2;187;186;210;185;192;185;185;188;185;175 09:36:38 INFO - PID 18385 | |13;stanford-crypto-sha256-iterative;73;70;67;70;69;69;72;71;69;67 09:36:38 INFO - PID 18385 | __end_tp_report 09:36:38 INFO - PID 18385 | __start_cc_report 09:36:38 INFO - PID 18385 | _x_x_mozilla_cycle_collect,965 09:36:38 INFO - PID 18385 | __end_cc_report 09:36:38 INFO - PID 18385 | __startTimestamp1497890198786__endTimestamp 09:36:38 INFO - PID 18385 | 09:36:38 INFO - PID 18385 | ------- Summary: start ------- 09:36:38 INFO - PID 18385 | Number of tests: 14 09:36:38 INFO - PID 18385 | 09:36:38 INFO - PID 18385 | [#0] ai-astar Cycles:10 Average:108.00 Median:108.00 stddev:2.83 (2.6%) stddev-sans-first:2.00 09:36:38 INFO - PID 18385 | Values: 102.0 108.0 108.0 107.0 113.0 107.0 111.0 108.0 108.0 108.0 09:36:38 INFO - PID 18385 | 09:36:38 INFO - PID 18385 | [#1] audio-beat-detection Cycles:10 Average:148.10 Median:153.50 stddev:23.84 (15.5%) stddev-sans-first:25.27 09:36:38 INFO - PID 18385 | Values: 151.0 124.0 151.0 181.0 128.0 162.0 156.0 122.0 185.0 121.0 09:36:38 INFO - PID 18385 | 09:36:38 INFO - PID 18385 | [#2] audio-dft Cycles:10 Average:165.90 Median:166.50 stddev:3.73 (2.2%) stddev-sans-first:3.95 09:36:38 INFO - PID 18385 | Values: 166.0 167.0 162.0 162.0 164.0 173.0 171.0 167.0 163.0 164.0 09:36:38 INFO - PID 18385 | 09:36:38 INFO - PID 18385 | [#3] audio-fft Cycles:10 Average:87.10 Median:75.50 stddev:30.35 (40.2%) stddev-sans-first:31.93 09:36:38 INFO - PID 18385 | Values: 76.0 75.0 75.0 172.0 79.0 74.0 75.0 77.0 93.0 75.0 09:36:38 INFO - PID 18385 | 09:36:38 INFO - PID 18385 | [#4] audio-oscillator Cycles:10 Average:98.90 Median:82.50 stddev:26.10 (31.6%) stddev-sans-first:26.95 09:36:38 INFO - PID 18385 | Values: 82.0 81.0 139.0 82.0 84.0 83.0 136.0 84.0 83.0 135.0 09:36:38 INFO - PID 18385 | 09:36:38 INFO - PID 18385 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 09:36:38 INFO - PID 18385 | Values: 114.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 116.0 115.0 09:36:38 INFO - PID 18385 | 09:36:38 INFO - PID 18385 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:151.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 09:36:38 INFO - PID 18385 | Values: 151.0 150.0 150.0 150.0 152.0 151.0 151.0 150.0 149.0 151.0 09:36:38 INFO - PID 18385 | 09:36:38 INFO - PID 18385 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 09:36:38 INFO - PID 18385 | Values: 95.0 94.0 94.0 94.0 95.0 94.0 94.0 95.0 94.0 94.0 09:36:38 INFO - PID 18385 | 09:36:38 INFO - PID 18385 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.50 stddev:1.99 (3.6%) stddev-sans-first:2.06 09:36:38 INFO - PID 18385 | Values: 56.0 53.0 53.0 56.0 54.0 53.0 59.0 55.0 53.0 56.0 09:36:38 INFO - PID 18385 | 09:36:38 INFO - PID 18385 | [#9] json-stringify-tinderbox Cycles:10 Average:54.90 Median:54.00 stddev:2.23 (4.1%) stddev-sans-first:2.26 09:36:38 INFO - PID 18385 | Values: 53.0 54.0 54.0 54.0 54.0 54.0 59.0 59.0 55.0 53.0 09:36:38 INFO - PID 18385 | 09:36:38 INFO - PID 18385 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:78.00 stddev:4.38 (5.6%) stddev-sans-first:4.61 09:36:38 INFO - PID 18385 | Values: 78.0 89.0 77.0 78.0 78.0 86.0 78.0 77.0 77.0 76.0 09:36:38 INFO - PID 18385 | 09:36:38 INFO - PID 18385 | [#11] stanford-crypto-ccm Cycles:10 Average:136.60 Median:140.50 stddev:6.22 (4.4%) stddev-sans-first:6.60 09:36:38 INFO - PID 18385 | Values: 136.0 141.0 141.0 132.0 126.0 140.0 134.0 142.0 129.0 145.0 09:36:38 INFO - PID 18385 | 09:36:38 INFO - PID 18385 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.80 Median:186.50 stddev:8.88 (4.8%) stddev-sans-first:9.41 09:36:38 INFO - PID 18385 | Values: 187.0 186.0 210.0 185.0 192.0 185.0 185.0 188.0 185.0 175.0 09:36:38 INFO - PID 18385 | 09:36:38 INFO - PID 18385 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:1.95 (2.8%) stddev-sans-first:1.66 09:36:38 INFO - PID 18385 | Values: 73.0 70.0 67.0 70.0 69.0 69.0 72.0 71.0 69.0 67.0 09:36:38 INFO - PID 18385 | -------- Summary: end -------- 09:36:38 INFO - PID 18385 | 09:36:39 INFO - TEST-INFO | 18385: exit 0 09:36:39 INFO - TEST-OK | kraken | took 62950ms 09:36:39 INFO - SUITE-END | took 1181s 09:36:40 INFO - Completed test suite (00:19:41) 09:36:40 INFO - javascript benchmark 09:36:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8181.232205340362, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3069.447499450098, 3095.644000939892, 3119.1578273866057, 3125.7655675824317, 3139.1524288442115, 6091.390860913912, 6109.969450152743, 6114.875284800365, 6129.4810485740945, 6159.414855588723, 6162.969185154079, 6187.75248990041, 6193.380661933805, 6197.566170368076, 6211.254649442062, 5678.659280443187, 5680.147977803321, 5690.06113991191, 5707.942920570783, 5753.741081651336, 5543.057680194356, 5613.07384281591, 5616.887662246752, 5708.315002199742, 5708.77164913403, 5525.917111243294, 5606.299212598426, 5653.462921022497, 5693.857653558653, 5705.030144875381, 5684.147377893349, 5701.14482827575, 5701.914471282934, 5723.370429252821, 5726.570507211975, 5579.0515612346, 5633.408492108351, 5636.971815140939, 5655.915161272585, 5657.547396208293, 6067.848303792396, 6118.20463339763, 6137.508999280047, 6154.046122850965, 6160.815175544741, 6453.322401147859, 6522.804315870531, 6557.278699343116, 6563.442107420875, 6618.966905165492, 6677.198736151693, 6705.362990515893, 6708.899366509506, 6717.865642687118, 6722.865542689167, 6113.0, 6166.445019948226, 6183.628982261079, 6189.0097584386285, 6194.659293738888, 6651.0, 6729.966350168315, 6732.394084532318, 6736.8989465158065, 6765.391114799691, 6355.459785918156, 6375.852346577568, 6496.123023391876, 6518.934810651833, 6545.476361891037, 6580.11168492257, 6609.5373323867825, 6623.337666233435, 6630.403263706289, 6666.666666666647, 6482.189726284215, 6611.471082313404, 6634.86730265392, 6641.070250164981, 6660.833479162963, 6547.214334279822, 6560.475161987029, 6567.408933196035, 6617.338266173344, 6619.304972977864, 5346.064438723286, 5371.75827087782, 5380.892382152335, 5382.730863456812, 5412.78348866041, 4538.977305113453, 4608.193566125915, 4622.214223581999, 4627.884302892455, 4649.418822647169, 5865.296164460292, 5866.70666466675, 5866.794662186803, 5882.470577648032, 5897.174395584621, 6499.740010399626, 6665.200175978816, 6673.399394054559, 6691.866162676719, 6719.865602687919, 5747.339056008529, 5760.222369979999, 5761.049426844607, 5805.7387417566315, 5840.386759390203, 5837.09525023622, 5837.620554663933, 5940.405959404025, 5947.1376650385455, 5955.880882382328, 6468.741250350027, 6523.0, 6523.24982626985, 6524.4454221389815, 6528.445082168069, 6725.932740672531, 6741.898871516833, 6742.9662851685425, 6744.527883048139, 6756.0, 6292.402221788922, 6375.681215939092, 6424.582402143846, 6425.389587989133, 6516.73933042673, 6465.353464653497, 6495.090687303876, 6500.414962653384, 6502.902456463252, 6512.0, 6708.664566771544, 6721.663916804043, 6724.4284235840505, 6726.226483954408, 6734.4612431004425, 6450.322716114928, 6455.870882582416, 6465.676716164079, 6468.741250349934, 6496.090547323473, 6286.465650419766, 6403.4877209824035, 6413.935860641521, 6415.6471394071905, 6462.612243265419, 6259.311475737574, 6311.589746666452, 6381.0, 6386.616802991835, 6435.549511534147, 6455.160829092188, 6580.144581204413, 6580.901286480611, 6588.110605068255, 6601.801945941629, 6370.140031095742, 6370.394812492806, 6373.904391434039, 6386.137871387489, 6394.776182833579], "value": 6052.529907852706, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [795.1968511803077, 838.9328853691705, 866.7876370289279, 894.1728900766789, 898.7753061734567, 39605.60394396059, 40218.99999999996, 40256.0, 40440.797796011015, 40509.59490405095, 35906.0, 36171.638283617154, 36284.81857590715, 36336.45495317572, 36347.0, 6751.696173672172, 6890.2076261230095, 6893.138357705287, 6902.689378977958, 6915.204751453572, 6765.560238584476, 6853.897191542131, 6872.553284036521, 6882.5870447773295, 6885.621290829003, 6800.523963322569, 6833.214180369271, 6863.519553631248, 6867.278935711754, 6897.689603967809, 6818.0795592595105, 6830.6243156626115, 6833.453323734139, 6843.931560684404, 6851.109355783717, 6134.754609815602, 6188.96905515474, 6193.0710393440895, 6198.349173336825, 7478.401727861758, 36448.63551364505, 36515.087122822144, 36691.4496282556, 36781.0, 36839.0, 3433.8454769535433, 3466.1507930556922, 3468.289000754839, 3473.670001349893, 3483.059573915029, 29854.552181717292, 29897.25256868574, 29908.700912991026, 29912.756543259344, 30111.849440752874, 3526.2242306692488, 3590.263995880864, 3619.2942376236642, 3623.655752703515, 3658.6158453362546, 185380.0, 185952.0, 186080.0, 187905.0, 188319.99999999863, 47579.76210118927, 48014.759926200844, 48407.515924841005, 48513.272300915516, 48622.75688621534, 50296.74851625792, 50803.23795143076, 50817.0, 50849.23726144111, 51090.744546277776, 15324.463643772415, 15369.615759606098, 15419.0, 15452.845471545366, 15480.690386192438, 12701.809472857914, 12718.236905785683, 12799.808002879965, 12812.679683008, 12817.0, 13910.652233694036, 13927.791083133761, 13957.232352220726, 14021.719565608835, 14070.0, 5740.483356497935, 5765.1928729977835, 5770.451807078321, 5786.971065144648, 5825.854353641108, 984.5471083301618, 988.3625061835077, 999.9950000249952, 1024.6516184497307, 1024.7591815923251, 22370.440738981655, 22856.428589285402, 22970.851457427063, 23073.769262307163, 23612.527749444915, 1075.6235317638764, 1095.3393311459688, 1112.404863398078, 1117.407773879845, 1122.7080958950733, 11824.467898944396, 11943.462544185533, 12157.696057598454, 12168.513259469522, 12399.820350316919, 212416.0, 215016.0, 215258.0, 215319.0, 215376.0, 51789.0, 52014.479855201724, 52110.0, 52180.47819521756, 52346.73826630843, 1426.621945184527, 1448.1745405118982, 1469.3094245704501, 1488.4567132996378, 1494.4321157960123, 21995.780042199374, 22416.551668966855, 22433.32700019002, 23196.0, 23337.76662233356, 36733.26533469262, 36967.0, 36993.44509832408, 37074.0, 37162.0, 168679.1566042162, 169073.0, 169929.0, 170315.0, 170657.0, 30434.239144021576, 30883.536746949263, 30943.226419339695, 32106.0, 32765.672343276263, 40567.1886562273, 41544.58455415528, 42708.35937461003, 42989.78505107454, 43059.138817222854, 29159.85420072886, 30107.69892301049, 30342.0, 30791.445987808176, 31919.444305632274, 29843.0, 29892.55161172541, 30726.84636576892, 31301.8434907824, 31633.0, 32870.506942395405, 33826.3234735299, 34130.48804267888, 34340.656593434745, 34991.65008349986, 28592.71407285984, 29284.56073158947, 29529.85235073811, 30057.54913676253, 30519.389612208077, 23330.183443579393, 24249.878750606134, 24456.633150503112, 24586.754132459162, 24765.25704228876], "value": 16246.458728358917, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.4740128374835, 555.3641080962295, 560.6299842104212, 562.7833284185588, 578.2973686970331, 20483.487912802168, 21688.674669879943, 21721.456963575918, 21794.782052179475, 21832.0, 23492.412689682722, 24560.508789824195, 25819.741802581968, 25958.091466798665, 26146.215613531578, 6447.935520644781, 6559.540832141752, 6560.179977502812, 6568.540202185849, 6568.7372505099975, 6508.381703738161, 6579.309172536887, 6581.7696380626685, 6587.47300215984, 6594.043863639769, 5907.350191478934, 6379.808605741835, 6468.773592924249, 6527.347265273482, 6544.574602650836, 6381.808545743612, 6425.06836508706, 6442.645654489002, 6457.61254324742, 6481.708323125495, 5993.940060599425, 6006.819795406102, 6019.097135429677, 6020.69896505173, 6026.427489388501, 27356.45287094247, 28229.717702822913, 28440.28899277514, 28706.712932870614, 28765.424691506054, 1856.5637075287298, 1915.329634627883, 1922.1254329280284, 1941.2526177421653, 1944.4361135270753, 17786.199621017084, 18211.63576728471, 18223.362182323555, 18238.08809559517, 18301.267949282144, 2340.2511196417154, 2343.9296821095395, 2388.044782087162, 2390.988045059781, 2427.8057755379705, 122320.0, 127601.36199319037, 127798.3610081953, 128478.0, 128883.35558322242, 13466.124701894345, 14471.204083775494, 14566.4901728439, 14744.778828317583, 15156.968606278788, 23217.651735223986, 23286.767132328798, 23321.7667823323, 23323.300300991, 23330.533389332457, 9732.367396119229, 9870.901290987142, 9955.402675839472, 10037.598496060076, 10106.949465252774, 9131.178193962442, 9186.81626367469, 9188.95405522968, 9210.63157473707, 9278.72163835086, 8974.596143173572, 9005.14451127142, 9093.954195267628, 9176.17414432691, 9179.265658747285, 2610.1777939948856, 2638.60420936861, 2706.120510833987, 2781.206122051306, 2821.4357128574366, 967.9564419601135, 986.2603047714215, 988.3625061835077, 1009.3439264478149, 1014.4116412480892, 19226.230950762092, 19390.903045484683, 20006.099725512388, 20023.799762002192, 20210.494737631678, 993.5429702336861, 1023.902729240721, 1036.2228328753436, 1050.3172937590627, 1059.0944742245424, 10670.51982660782, 10897.564097436014, 11013.339199648046, 11289.322640641587, 12469.563565275172, 521365.0, 539666.0, 550764.0, 554126.0, 554526.0, 111263.0, 112042.43978780054, 113430.43284783523, 114823.42588287173, 114840.0, 1201.741625550511, 1242.3105176626877, 1263.109507797001, 1268.422867595242, 1275.9362031898554, 18862.811371886106, 20701.27545535899, 20728.17087316551, 20886.0, 20965.266215682987, 49495.50504494909, 53230.46769532255, 54024.0, 54689.453105468434, 54847.45152548583, 65910.67044664746, 66657.0, 67117.32882671306, 67240.0, 67788.3221167782, 12618.55835045769, 12683.682907927376, 12743.044271679846, 12784.808227876776, 12827.679308017001, 17902.194401251716, 18773.155208015945, 18817.247310107443, 18921.243150273836, 19073.237070517578, 14762.188079655722, 15456.690866182389, 15532.534023979299, 15563.221838908235, 15568.844311556739, 13533.932330338286, 13779.311034448037, 13816.516421925184, 13911.721765564835, 14176.220307883166, 15719.68560628804, 15800.683986320439, 15879.52361429159, 16030.67938641244, 16045.19774011318, 11809.173357864867, 12448.377581120727, 12567.0, 12569.183003104768, 12600.873991260336, 15284.77072843886, 15420.0, 15420.537383878502, 15494.922525387301, 15808.0], "value": 11481.496657164895, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1350.8851747601454, 1413.4982081361115, 1415.18626789596, 1417.6172433442978, 1428.2929949674908, 12439.315837628927, 13038.73922521549, 13057.412416441259, 13091.345432728362, 13095.607131786062, 12573.685657858558, 12929.612111636643, 12932.22406655599, 12943.417546210443, 12989.350532473361, 2311.6185829338183, 2341.344423561397, 2365.254944692425, 2367.5856725073045, 2378.298401971414, 2003.0986056274662, 2034.6541088015074, 2035.3385149826292, 2047.7440319960006, 2048.5185981294385, 2138.8502804803593, 2171.381156370435, 2183.061283648031, 2184.770599087097, 2194.188150384352, 2216.213244298267, 2224.8887555622237, 2237.362351729749, 2246.898889549966, 2247.2808701215536, 2174.282486779359, 2259.175400978631, 2270.2848602690265, 2282.6804247405375, 2293.6559516072557, 13015.804762928563, 13089.0, 13143.27711975841, 13177.341132943315, 13188.934055329757, 7016.193137789169, 7310.671019804122, 7322.1579518355, 7343.559386436831, 7350.044494215717, 4114.0, 4234.06850492891, 4313.892152696177, 4316.784160791979, 4362.1275744851155, 1451.4049239811732, 1490.5975386645546, 1503.9097654140787, 1561.2505997121332, 1584.5167223996677, 18204.36284730028, 18845.90577047106, 19775.110120044632, 19793.505162371057, 20029.899850500653, 5424.945750542523, 5583.609147359646, 5858.765649373977, 6075.544334174954, 6100.69496525172, 14312.928435357964, 14334.928325358307, 14346.641333966525, 14404.855951440351, 14418.783718244234, 6875.312468753084, 6898.827529311808, 6918.8962165567555, 6924.480663950224, 6925.376716095576, 6408.711607977652, 6547.247066587308, 6608.140941677551, 6632.834179145463, 6645.401913827779, 4127.215828992482, 4243.087736136746, 4267.786610669516, 4363.759993200404, 4367.388565600819, 1325.7613629546775, 1337.9331033448289, 1348.110247236819, 1352.7700290950365, 1374.0793668242302, 911.8951320598217, 922.9169374756304, 924.4453328003278, 946.9857952130724, 962.7208109648124, 7304.160021597478, 7427.888581671279, 7995.760127196193, 8559.315254779603, 8600.354973377021, 1006.6979906028308, 1020.811149937264, 1023.7747695506977, 1025.5692609104194, 1041.1878734587035, 4983.900321993612, 5142.9742851286255, 5426.620136590401, 5513.09034009384, 5687.175359572839, 17014.744778828328, 17456.563585910455, 17618.82381176172, 17637.294508219784, 17647.911760441115, 17057.744133838, 17285.740713889303, 17361.913190433967, 17405.0, 17571.824281757275, 9724.513774311255, 10060.949695251476, 10228.948855255825, 10238.18094552434, 10315.432651204255, 7713.730019449293, 7739.264769846855, 8202.507849529047, 8254.958725206576, 8599.0, 14354.569362919128, 14357.856421435652, 14976.326065326868, 14983.550493485212, 15026.849731502545, 13681.384337704629, 15087.0, 15257.237138143271, 15342.232888355315, 15409.075455472708, 10500.264981451224, 10625.9468702656, 10710.839337409789, 10720.0, 10735.141188705042, 11397.886021140013, 11422.771544568895, 11802.704932376759, 12427.813582796085, 12429.627111186679, 9711.465869376969, 10348.120409764953, 10361.326513776581, 10451.111655509063, 10540.10409115203, 9605.135537801352, 9853.556589953612, 10200.183985281308, 10343.94828025855, 10478.266521343432, 9191.448513089235, 9222.40054396462, 9244.491552964651, 9275.76810579741, 9309.906900931175, 6402.487800976004, 6562.901556476561, 6950.165980082423, 6953.930460695328, 6989.475789315923, 6786.355296246848, 7045.436365090883, 7225.458090643117, 7314.4148468123485, 7385.667644956097], "value": 5853.137191673035, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [478.8036904869002, 491.5060364333844, 506.071359056132, 510.14550627698594, 513.1430511046552, 6324.715387807548, 6413.262474815398, 6423.357664233575, 6431.871362572751, 6478.125453063835, 6144.692765361725, 6296.433321001109, 6300.960341543651, 6323.494120470363, 6327.905081423783, 5063.392392912856, 5074.340335756356, 5078.771455284503, 5085.160948443521, 5105.4128775190775, 5072.771725272371, 5096.821611243608, 5097.745112744366, 5119.744012799364, 5162.199859021857, 5067.0, 5071.492850714917, 5079.873003174932, 5094.77073531692, 5104.64267501275, 4885.340479035338, 5048.747562621891, 5063.974680126613, 5077.49225077493, 5089.312942752718, 4506.752128632924, 4506.977465112654, 4512.86461406155, 4518.277075667877, 4547.090581883604, 6168.383161683841, 6186.56694031418, 6207.596506227081, 6217.222847144107, 6222.875542489125, 5769.971150144264, 5813.43037379905, 5821.18503409523, 5828.854278643068, 5846.795362162304, 6756.729730810762, 6761.222459417181, 6774.0, 6785.457163426963, 6791.0, 4917.483664215241, 4934.383202099738, 4941.665750247449, 4942.728149951751, 4960.553550180501, 7044.788656340318, 7108.715651373939, 7149.571025738473, 7155.141383034017, 7171.426285897168, 5043.949560504348, 5070.6957582545165, 5074.82238121664, 5084.703400632889, 5089.244210747286, 5142.04872098663, 5145.665531740425, 5146.253793199965, 5146.845594632167, 5147.356580427447, 5810.7628563003545, 5814.360420353758, 5817.894600025981, 5842.415758424124, 5844.240248767633, 6816.931830681729, 6841.2132604750095, 6850.2598960416235, 6853.931460685429, 6862.656867156622, 1666.7666526686273, 1755.7709603277756, 1764.5765016395972, 1770.822917708219, 1777.8399944005102, 1196.5692350753723, 1197.9580714674944, 1211.0372254058045, 1231.8213858990575, 1231.8644949055597, 5754.625949313365, 5875.0, 5894.734736936848, 5959.106134079922, 5962.522998160137, 6781.220159681699, 6922.546265284246, 6935.618540980295, 6963.9303606964295, 6968.547044442095, 5839.2992840858515, 5872.324682661463, 5905.911411328833, 5907.409259074144, 5961.225040744762, 3627.9637203628154, 3642.1987162824134, 3650.9817450913106, 3660.670539651444, 3676.4485327201132, 6620.602763834186, 6620.635865027373, 6621.602703837785, 6657.866842663217, 6675.7997260082275, 7040.084788977502, 7048.259932707095, 7060.470464715167, 7082.256363081905, 7088.149422069385, 6637.767678131146, 6647.700853461509, 6648.135742353463, 6680.83297917556, 6691.297413771581, 6746.932530674827, 6824.839777237782, 6834.624095674786, 6846.623435711083, 6861.965690171517, 6725.159355080615, 6769.092408004158, 6791.286914873867, 6792.962111366669, 6815.727370905108, 6269.655168965568, 6566.671666416564, 6649.235337936199, 6670.731951136637, 6696.966515167393, 4875.268709693574, 4986.526280003394, 5002.574781143643, 5027.0, 5082.669626474268, 6916.723331066701, 6919.550229235084, 6931.965340173267, 6971.0, 6991.650417479004, 6664.4668426524795, 6676.966615167087, 6687.498437617295, 6695.330466953265, 6696.899546506904, 6616.4045235929, 6656.434203092597, 6712.429443497357, 6727.26000139994, 6737.629430381376, 6565.343465653396, 6584.934150658623, 6629.270780214076, 6664.435531002056, 6677.899831502628, 6711.349017138301, 6769.28922463154, 6806.7957961261245, 6809.93190068093, 6827.224921520341, 6522.869542609216, 6572.0, 6601.900971485527, 6607.834804129935, 6610.206775187008], "value": 5155.824109050368, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [828.2793969246757, 830.2735106781566, 842.886210361601, 877.0527829943661, 894.977625559361, 17290.91354543227, 17386.565335866595, 17700.203490842912, 17706.20322085506, 17880.37418690346, 15764.684706305867, 15856.28646710898, 17341.826581734178, 18019.63960720785, 19101.0, 1022.4580972084807, 1058.91528677706, 1069.9732506687317, 1070.288258308228, 1074.3231763988676, 1068.7274744940069, 1082.5940272397852, 1089.4933855757072, 1091.7761858818963, 1092.049916572583, 1125.139268459629, 1125.4372813593204, 1135.9602413915516, 1137.1244142010646, 1137.852079229699, 1053.7629033467485, 1082.1883587309517, 1105.8562386889732, 1119.0599896087285, 1122.4724379541603, 792.374024520628, 808.640155130967, 811.0227176252602, 811.217175425717, 813.3005615170948, 18249.17878695462, 18377.816221837744, 18521.444356669323, 18537.35119270819, 18618.813811861844, 19003.144858481402, 19469.902650486798, 19571.608567828705, 19655.115519801642, 19696.704549431626, 14724.19016954067, 14917.925410372987, 14992.0, 15053.5483935481, 15139.091654500766, 3396.677315655009, 3423.8972830815114, 3425.1094715373933, 3426.43463828468, 3431.7940923544666, 96103.51948240215, 98388.50805745997, 99100.0, 100206.0, 101400.49299753527, 15809.446669366516, 15835.0, 16209.756853647204, 16212.837871621368, 16227.107509087113, 26459.73540264611, 28010.5798413024, 28140.155795326173, 28458.288542786595, 28630.427391452053, 8458.830823383498, 8471.576421178916, 8658.307335413152, 8775.780605484786, 8879.200871921557, 4082.101937573729, 4133.379993001074, 4144.48193975753, 4153.314703074019, 4171.436856024458, 4816.325714399987, 4888.095702295087, 4941.382327209099, 4988.80044798204, 4990.5508504234795, 1001.2240513601871, 1019.3934608907688, 1026.2918586175515, 1033.7984093101923, 1034.0383443397561, 694.2155364438153, 700.8913618389158, 705.368695017956, 707.5542408282749, 725.4269127389409, 11679.883201167879, 11954.983826374855, 12205.572804951784, 12942.352882355844, 13335.466581336637, 698.3400686351349, 717.5551158281794, 741.0288632238221, 748.135903031999, 748.8015675845905, 4955.306257124005, 4986.326845875833, 5185.403678577012, 5536.363318218457, 5553.861153471114, 93376.06623933809, 93861.5306923461, 94771.0, 97332.51333743427, 100554.49722751339, 62803.0, 82236.0, 84384.57807711045, 86210.56894715612, 88110.55944720235, 64994.0, 71596.28403716, 73162.63418682979, 74219.62890185622, 74775.0, 12019.67783543827, 12246.203996740183, 12357.75284494287, 12623.431945562288, 12766.68083297925, 32283.716283716283, 32423.83788081139, 34512.48231276483, 34799.47800783041, 34891.65108348884, 57867.0, 61090.0, 63444.0, 63686.0, 64032.67983660052, 17030.403935862185, 17906.820931790517, 18269.0, 18290.81709182891, 18322.81677183211, 20564.0, 20823.271185508434, 21129.0, 21137.682934755685, 21390.679139813226, 17173.398931037354, 18732.719009215147, 19097.236110555423, 19175.137118829407, 19303.613927721646, 18216.726749099038, 18729.250829966648, 18790.812091878906, 19569.315073972342, 19811.603767924847, 17712.202950866984, 17899.910500447415, 18000.90999544994, 18049.909750451163, 18980.810191897905, 12145.210561313486, 12828.20405143262, 13108.0, 13666.0, 13771.242581658105, 13205.405756740778, 14592.489262875748, 14955.626109347353, 14997.550073497812, 15388.38446462129], "value": 8800.46820919824, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1550.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 108.0, 108.0, 107.0, 113.0, 107.0, 111.0, 108.0, 108.0, 108.0], "value": 108.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 124.0, 151.0, 181.0, 128.0, 162.0, 156.0, 122.0, 185.0, 121.0], "value": 148.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 162.0, 162.0, 164.0, 173.0, 171.0, 167.0, 163.0, 164.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 172.0, 79.0, 74.0, 75.0, 77.0, 93.0, 75.0], "value": 87.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 139.0, 82.0, 84.0, 83.0, 136.0, 84.0, 83.0, 135.0], "value": 98.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 116.0, 115.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 150.0, 150.0, 152.0, 151.0, 151.0, 150.0, 149.0, 151.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 53.0, 56.0, 54.0, 53.0, 59.0, 55.0, 53.0, 56.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 54.0, 54.0, 54.0, 59.0, 59.0, 55.0, 53.0], "value": 54.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 89.0, 77.0, 78.0, 78.0, 86.0, 78.0, 77.0, 77.0, 76.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 141.0, 141.0, 132.0, 126.0, 140.0, 134.0, 142.0, 129.0, 145.0], "value": 136.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 186.0, 210.0, 185.0, 192.0, 185.0, 185.0, 188.0, 185.0, 175.0], "value": 187.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 70.0, 67.0, 70.0, 69.0, 69.0, 72.0, 71.0, 69.0, 67.0], "value": 69.7, "unit": "score"}]}]} 09:36:40 INFO - Return code: 0 09:36:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:36:40 INFO - # TBPL SUCCESS # 09:36:40 INFO - Running post-action listener: _resource_record_post_action 09:36:40 INFO - [mozharness: 2017-06-19 16:36:40.130111Z] Finished run-tests step (success) 09:36:40 INFO - Running post-run listener: _resource_record_post_run 09:36:40 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 16384; Write bytes: 424374272; Read time: 348; Write time: 645592 09:36:40 INFO - TinderboxPrint: CPU usage
13.3% 09:36:40 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 348 09:36:40 INFO - TinderboxPrint: I/O write bytes / time
424,374,272 / 645,592 09:36:40 INFO - TinderboxPrint: CPU idle
8,291.6 (86.7%) 09:36:40 INFO - TinderboxPrint: CPU user
1,212.6 (12.7%) 09:36:40 INFO - TinderboxPrint: Swap in / out
0 / 0 09:36:40 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 4096; Write bytes: 103124992; Read time: 176; Write time: 212748 09:36:40 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:36:40 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 12288; Write bytes: 321249280; Read time: 172; Write time: 432844 09:36:40 INFO - Running post-run listener: _upload_blobber_files 09:36:40 INFO - Blob upload gear active. 09:36:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:36:40 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:36:40 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'] 09:36:40 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 09:36:41 INFO - (blobuploader) - INFO - Open directory for files ... 09:36:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:36:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:36:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:41 INFO - (blobuploader) - INFO - Done attempting. 09:36:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:36:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:36:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:48 INFO - (blobuploader) - INFO - Done attempting. 09:36:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:36:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:36:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:49 INFO - (blobuploader) - INFO - Done attempting. 09:36:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:36:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:36:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:50 INFO - (blobuploader) - INFO - Done attempting. 09:36:50 INFO - (blobuploader) - INFO - Iteration through files over. 09:36:50 INFO - Return code: 0 09:36:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:36:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:36:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d5af8d56dc39a07b4de6fcf2520d4a9edde552a03059e53bbdc5a15ea1fc79330979f80e2d163c253437d9e90ffd311c882312aee253454bc5e946b51e9e5dff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/24ef08f61816aaf9d4726b0058964fd001cc32b4f85129337b3d1eb191fb49742613d8685a5127efa8397fccbddf7b39e24f63ec2212b207af366cff3c764ebc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1a8a16c2a047c7f5c0ddc6fbef69e0dc2b2fe27044ba9ee4d8a5638a0154b918aac95b7d7d4acdeefd8feda3b2def7153dc6a73551bc512a52e0d2145d4658b9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/da8df741b5136ef2f6c25ee48f6c9c459d3b276c257fbc98f16707190f1e5047d488bb8ca87d927fbb5930cfa5024b99551539ab72b7ad185dd4e4592552a911"} 09:36:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:36:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:36:50 INFO - Contents: 09:36:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d5af8d56dc39a07b4de6fcf2520d4a9edde552a03059e53bbdc5a15ea1fc79330979f80e2d163c253437d9e90ffd311c882312aee253454bc5e946b51e9e5dff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/24ef08f61816aaf9d4726b0058964fd001cc32b4f85129337b3d1eb191fb49742613d8685a5127efa8397fccbddf7b39e24f63ec2212b207af366cff3c764ebc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1a8a16c2a047c7f5c0ddc6fbef69e0dc2b2fe27044ba9ee4d8a5638a0154b918aac95b7d7d4acdeefd8feda3b2def7153dc6a73551bc512a52e0d2145d4658b9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/da8df741b5136ef2f6c25ee48f6c9c459d3b276c257fbc98f16707190f1e5047d488bb8ca87d927fbb5930cfa5024b99551539ab72b7ad185dd4e4592552a911"} 09:36:50 INFO - Running post-run listener: copy_logs_to_upload_dir 09:36:50 INFO - Copying logs to upload dir... 09:36:50 INFO - mkdir: /builds/slave/test/build/upload/logs 09:36:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.229854 ========= master_lag: 0.27 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-06-19 09:36:50.169420) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-19 09:36:50.176431) ========= 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=8783db0840cc980e80bb0bd400000236-1497882641.372768-1313985863 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/d5af8d56dc39a07b4de6fcf2520d4a9edde552a03059e53bbdc5a15ea1fc79330979f80e2d163c253437d9e90ffd311c882312aee253454bc5e946b51e9e5dff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/24ef08f61816aaf9d4726b0058964fd001cc32b4f85129337b3d1eb191fb49742613d8685a5127efa8397fccbddf7b39e24f63ec2212b207af366cff3c764ebc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1a8a16c2a047c7f5c0ddc6fbef69e0dc2b2fe27044ba9ee4d8a5638a0154b918aac95b7d7d4acdeefd8feda3b2def7153dc6a73551bc512a52e0d2145d4658b9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/da8df741b5136ef2f6c25ee48f6c9c459d3b276c257fbc98f16707190f1e5047d488bb8ca87d927fbb5930cfa5024b99551539ab72b7ad185dd4e4592552a911"} build_url:https://queue.taskcluster.net/v1/task/e2STNDhHQv2F-9vOiEUE3w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011456 build_url: 'https://queue.taskcluster.net/v1/task/e2STNDhHQv2F-9vOiEUE3w/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d5af8d56dc39a07b4de6fcf2520d4a9edde552a03059e53bbdc5a15ea1fc79330979f80e2d163c253437d9e90ffd311c882312aee253454bc5e946b51e9e5dff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/24ef08f61816aaf9d4726b0058964fd001cc32b4f85129337b3d1eb191fb49742613d8685a5127efa8397fccbddf7b39e24f63ec2212b207af366cff3c764ebc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1a8a16c2a047c7f5c0ddc6fbef69e0dc2b2fe27044ba9ee4d8a5638a0154b918aac95b7d7d4acdeefd8feda3b2def7153dc6a73551bc512a52e0d2145d4658b9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/da8df741b5136ef2f6c25ee48f6c9c459d3b276c257fbc98f16707190f1e5047d488bb8ca87d927fbb5930cfa5024b99551539ab72b7ad185dd4e4592552a911"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-19 09:36:50.203185) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-19 09:36:50.203485) ========= 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=8783db0840cc980e80bb0bd400000236-1497882641.372768-1313985863 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004681 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-19 09:36:50.251140) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-19 09:36:50.251418) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-19 09:36:50.251690) ========= ========= Total master_lag: 0.38 =========