builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-031 starttime: 1497050328.82 results: success (0) revision: c4e74cfbf7e9d8e297e214478d25e3456f858cea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-09 16:18:48.816395) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-09 16:18:48.816851) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-09 16:18:48.817283) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-09 16:18:48.878262) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-09 16:18:48.878554) ========= 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=db0483c52d987ecb441a263b000001ad-1497038885.99686-1458522901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-09 16:18:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.9M=0s 2017-06-09 16:18:49 (39.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.184290 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-09 16:18:49.084829) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-09 16:18:49.088198) ========= 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=db0483c52d987ecb441a263b000001ad-1497038885.99686-1458522901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020588 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-09 16:18:49.138903) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-09 16:18:49.139374) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c4e74cfbf7e9d8e297e214478d25e3456f858cea --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 c4e74cfbf7e9d8e297e214478d25e3456f858cea --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=db0483c52d987ecb441a263b000001ad-1497038885.99686-1458522901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-09 16:18:49,538 truncating revision to first 12 chars 2017-06-09 16:18:49,538 Setting DEBUG logging. 2017-06-09 16:18:49,538 attempt 1/10 2017-06-09 16:18:49,538 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c4e74cfbf7e9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-09 16:18:50,739 unpacking tar archive at: mozilla-central-c4e74cfbf7e9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.783432 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-09 16:18:50.938488) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-09 16:18:50.938784) ========= script_repo_revision: c4e74cfbf7e9d8e297e214478d25e3456f858cea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-09 16:18:50.939178) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-09 16:18:50.939444) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-09 16:18:50.951856) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2017-06-09 16:18:50.952134) ========= /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=db0483c52d987ecb441a263b000001ad-1497038885.99686-1458522901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:18:51 INFO - MultiFileLogger online at 20170609 16:18:51 in /builds/slave/test 16:18:51 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 16:18:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:18:51 INFO - {'append_to_log': False, 16:18:51 INFO - 'base_work_dir': '/builds/slave/test', 16:18:51 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:18:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:18:51 INFO - 'branch': 'Firefox-Non-PGO', 16:18:51 INFO - 'buildbot_json_path': 'buildprops.json', 16:18:51 INFO - 'config_files': ('talos/linux_config.py',), 16:18:51 INFO - 'default_actions': ('clobber', 16:18:51 INFO - 'read-buildbot-config', 16:18:51 INFO - 'download-and-extract', 16:18:51 INFO - 'populate-webroot', 16:18:51 INFO - 'create-virtualenv', 16:18:51 INFO - 'install', 16:18:51 INFO - 'setup-mitmproxy', 16:18:51 INFO - 'run-tests'), 16:18:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:18:51 INFO - 'download_minidump_stackwalk': True, 16:18:51 INFO - 'download_symbols': 'ondemand', 16:18:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:18:51 INFO - 'tooltool.py': '/tools/tooltool.py', 16:18:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:18:51 INFO - '/tools/misc-python/virtualenv.py')}, 16:18:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:18:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:18:51 INFO - 'gecko_profile': False, 16:18:51 INFO - 'gecko_profile_interval': 0, 16:18:51 INFO - 'installer_path': 'installer.exe', 16:18:51 INFO - 'log_level': 'info', 16:18:51 INFO - 'log_name': 'talos', 16:18:51 INFO - 'log_to_console': True, 16:18:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:18:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:18:51 INFO - 'opt_config_files': (), 16:18:51 INFO - 'pip_index': False, 16:18:51 INFO - 'suite': 'dromaeojs-e10s', 16:18:51 INFO - 'system_bits': '32', 16:18:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:18:51 INFO - 'title': 'talos-linux64-ix-031', 16:18:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:18:51 INFO - 'use_talos_json': True, 16:18:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:18:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:18:51 INFO - 'work_dir': 'build'} 16:18:51 INFO - [mozharness: 2017-06-09 23:18:51.564568Z] Running clobber step. 16:18:51 INFO - Running pre-action listener: _resource_record_pre_action 16:18:51 INFO - Running main action method: clobber 16:18:51 INFO - rmtree: /builds/slave/test/build 16:18:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:18:52 INFO - Running post-action listener: _resource_record_post_action 16:18:52 INFO - [mozharness: 2017-06-09 23:18:52.553962Z] Finished clobber step (success) 16:18:52 INFO - [mozharness: 2017-06-09 23:18:52.554064Z] Running read-buildbot-config step. 16:18:52 INFO - Running pre-action listener: _resource_record_pre_action 16:18:52 INFO - Running main action method: read_buildbot_config 16:18:52 INFO - Using buildbot properties: 16:18:52 INFO - { 16:18:52 INFO - "project": "", 16:18:52 INFO - "product": "firefox", 16:18:52 INFO - "who": "kwierso@gmail.com", 16:18:52 INFO - "installer_path": "public/build/target.tar.bz2", 16:18:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:18:52 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 16:18:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 16:18:52 INFO - "stage_platform": "linux64", 16:18:52 INFO - "basedir": "/builds/slave/test", 16:18:52 INFO - "buildnumber": 905, 16:18:52 INFO - "platform": "ubuntu64_hw", 16:18:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:18:52 INFO - "slavebuilddir": "test", 16:18:52 INFO - "taskId": "F3vem8EVSayYEHWmnprMiQ", 16:18:52 INFO - "branch": "mozilla-central", 16:18:52 INFO - "script_repo_revision": "production", 16:18:52 INFO - "revision": "c4e74cfbf7e9d8e297e214478d25e3456f858cea", 16:18:52 INFO - "slavename": "talos-linux64-ix-031", 16:18:52 INFO - "repo_path": "mozilla-central" 16:18:52 INFO - } 16:18:52 INFO - Finding installer, test and symbols from parent task. 16:18:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F3vem8EVSayYEHWmnprMiQ'}, attempt #1 16:18:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F3vem8EVSayYEHWmnprMiQ'}, attempt #1 16:18:53 INFO - Task dependencies: WOD1aXL-Re-nV13fq7Zfhg 16:18:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WOD1aXL-Re-nV13fq7Zfhg'}, attempt #1 16:18:53 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/WOD1aXL-Re-nV13fq7Zfhg/artifacts/public/build/target.tar.bz2 16:18:53 INFO - Set test_url: https://queue.taskcluster.net/v1/task/WOD1aXL-Re-nV13fq7Zfhg/artifacts/public/build/test_packages.json 16:18:53 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/WOD1aXL-Re-nV13fq7Zfhg/artifacts/public/build/target.crashreporter-symbols.zip 16:18:53 INFO - Running post-action listener: _resource_record_post_action 16:18:53 INFO - [mozharness: 2017-06-09 23:18:53.916953Z] Finished read-buildbot-config step (success) 16:18:53 INFO - [mozharness: 2017-06-09 23:18:53.917174Z] Running download-and-extract step. 16:18:53 INFO - Running pre-action listener: _resource_record_pre_action 16:18:53 INFO - Running main action method: download_and_extract 16:18:53 INFO - mkdir: /builds/slave/test/build/tests 16:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:18:53 INFO - trying https://queue.taskcluster.net/v1/task/WOD1aXL-Re-nV13fq7Zfhg/artifacts/public/build/target.test_packages.json 16:18:53 INFO - Downloading https://queue.taskcluster.net/v1/task/WOD1aXL-Re-nV13fq7Zfhg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:18:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WOD1aXL-Re-nV13fq7Zfhg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:18:54 INFO - Downloaded 989 bytes. 16:18:54 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:18:54 INFO - Using the following test package requirements: 16:18:54 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:18:54 INFO - u'common': [u'target.common.tests.zip'], 16:18:54 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:18:54 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:18:54 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:18:54 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:18:54 INFO - u'mozbase': [u'target.common.tests.zip'], 16:18:54 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:18:54 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:18:54 INFO - u'web-platform': [u'target.common.tests.zip', 16:18:54 INFO - u'target.web-platform.tests.tar.gz'], 16:18:54 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:18:54 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:18:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WOD1aXL-Re-nV13fq7Zfhg/artifacts/public/build/target.common.tests.zip 16:18:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WOD1aXL-Re-nV13fq7Zfhg/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:18:54 INFO - Fetch https://queue.taskcluster.net/v1/task/WOD1aXL-Re-nV13fq7Zfhg/artifacts/public/build/target.common.tests.zip into memory 16:18:56 INFO - Content-Length response header: 67876772 16:18:56 INFO - Bytes received: 67876772 16:19:07 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:19:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WOD1aXL-Re-nV13fq7Zfhg/artifacts/public/build/target.common.tests.zip 16:19:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WOD1aXL-Re-nV13fq7Zfhg/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:19:07 INFO - Fetch https://queue.taskcluster.net/v1/task/WOD1aXL-Re-nV13fq7Zfhg/artifacts/public/build/target.common.tests.zip into memory 16:19:09 INFO - Content-Length response header: 67876772 16:19:09 INFO - Bytes received: 67876772 16:19:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WOD1aXL-Re-nV13fq7Zfhg/artifacts/public/build/target.talos.tests.zip 16:19:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WOD1aXL-Re-nV13fq7Zfhg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:19:22 INFO - Fetch https://queue.taskcluster.net/v1/task/WOD1aXL-Re-nV13fq7Zfhg/artifacts/public/build/target.talos.tests.zip into memory 16:19:23 INFO - Content-Length response header: 14449999 16:19:23 INFO - Bytes received: 14449999 16:19: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')]} 16:19:23 INFO - trying https://queue.taskcluster.net/v1/task/WOD1aXL-Re-nV13fq7Zfhg/artifacts/public/build/target.tar.bz2 16:19:23 INFO - Downloading https://queue.taskcluster.net/v1/task/WOD1aXL-Re-nV13fq7Zfhg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:19:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WOD1aXL-Re-nV13fq7Zfhg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:19:24 INFO - Downloaded 59237170 bytes. 16:19:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WOD1aXL-Re-nV13fq7Zfhg/artifacts/public/build/target.tar.bz2 16:19:24 INFO - mkdir: /builds/slave/test/properties 16:19:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:19:24 INFO - Writing to file /builds/slave/test/properties/build_url 16:19:24 INFO - Contents: 16:19:24 INFO - build_url:https://queue.taskcluster.net/v1/task/WOD1aXL-Re-nV13fq7Zfhg/artifacts/public/build/target.tar.bz2 16:19:24 INFO - Running post-action listener: _resource_record_post_action 16:19:24 INFO - Running post-action listener: set_extra_try_arguments 16:19:24 INFO - [mozharness: 2017-06-09 23:19:24.524849Z] Finished download-and-extract step (success) 16:19:24 INFO - [mozharness: 2017-06-09 23:19:24.524945Z] Running populate-webroot step. 16:19:24 INFO - Running pre-action listener: _resource_record_pre_action 16:19:24 INFO - Running main action method: populate_webroot 16:19:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:19:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:19:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:19:24 INFO - '--tppagecycles', 16:19:24 INFO - '7'], 16:19:24 INFO - 'tests': ['tsvgm']}}, 16:19:24 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:19:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:19:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:19:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:19:24 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:19:24 INFO - 'talos_options': ['--disable-e10s'], 16:19:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:19:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:19:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:19:24 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:19:24 INFO - 'talos_options': ['--disable-e10s'], 16:19:24 INFO - 'tests': ['damp', 'tps']}, 16:19:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:19:24 INFO - 'tests': ['damp', 'tps']}, 16:19:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:19:24 INFO - 'tests': ['dromaeo_dom']}, 16:19:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:19:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:19:24 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:19:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:19:24 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:19:24 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:19:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:19:24 INFO - 'tests': ['a11yr', 16:19:24 INFO - 'ts_paint', 16:19:24 INFO - 'tpaint', 16:19:24 INFO - 'sessionrestore', 16:19:24 INFO - 'sessionrestore_no_auto_restore', 16:19:24 INFO - 'tabpaint']}, 16:19:24 INFO - 'other-e10s': {'tests': ['a11yr', 16:19:24 INFO - 'ts_paint', 16:19:24 INFO - 'tpaint', 16:19:24 INFO - 'sessionrestore', 16:19:24 INFO - 'sessionrestore_no_auto_restore', 16:19:24 INFO - 'tabpaint']}, 16:19:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:19:24 INFO - 'ts_paint', 16:19:24 INFO - 'tpaint', 16:19:24 INFO - 'sessionrestore', 16:19:24 INFO - 'sessionrestore_no_auto_restore', 16:19:24 INFO - 'tabpaint']}, 16:19:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:19:24 INFO - 'ts_paint', 16:19:24 INFO - 'tpaint', 16:19:24 INFO - 'sessionrestore', 16:19:24 INFO - 'sessionrestore_no_auto_restore', 16:19:24 INFO - 'tabpaint']}, 16:19:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:19:24 INFO - 'tests': ['a11yr', 16:19:24 INFO - 'ts_paint', 16:19:24 INFO - 'tpaint', 16:19:24 INFO - 'sessionrestore', 16:19:24 INFO - 'sessionrestore_no_auto_restore', 16:19:24 INFO - 'tabpaint']}, 16:19:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:19:24 INFO - 'tests': ['a11yr', 16:19:24 INFO - 'ts_paint', 16:19:24 INFO - 'tpaint', 16:19:24 INFO - 'sessionrestore', 16:19:24 INFO - 'sessionrestore_no_auto_restore', 16:19:24 INFO - 'tabpaint']}, 16:19:24 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 16:19:24 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 16:19:24 INFO - 'bloom_basic_ref']}, 16:19:24 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:19:24 INFO - 'talos_options': ['--mitmproxy', 16:19:24 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:19:24 INFO - '--firstNonBlankPaint'], 16:19:24 INFO - 'tests': ['quantum_pageload_google', 16:19:24 INFO - 'quantum_pageload_youtube', 16:19:24 INFO - 'quantum_pageload_amazon', 16:19:24 INFO - 'quantum_pageload_facebook']}, 16:19:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:19:24 INFO - 'tests': ['tsvgx', 16:19:24 INFO - 'tsvgr_opacity', 16:19:24 INFO - 'tart', 16:19:24 INFO - 'tscrollx', 16:19:24 INFO - 'cart', 16:19:24 INFO - 'tsvg_static']}, 16:19:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:19:24 INFO - 'tsvgr_opacity', 16:19:24 INFO - 'tart', 16:19:24 INFO - 'tscrollx', 16:19:24 INFO - 'cart', 16:19:24 INFO - 'tsvg_static']}, 16:19:24 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:19:24 INFO - 'talos_options': ['--disable-e10s'], 16:19:24 INFO - 'tests': ['tp5o']}, 16:19:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:19:24 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:19:24 INFO - 'talos_options': ['--disable-e10s', 16:19:24 INFO - '--xperf_path', 16:19:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:19:24 INFO - 'tests': ['tp5n']}, 16:19:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:19:24 INFO - 'talos_options': ['--xperf_path', 16:19:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:19:24 INFO - 'tests': ['tp5n']}}, 16:19:24 INFO - 'talos.zip': {'path': '', 16:19:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:19:24 INFO - Running post-action listener: _resource_record_post_action 16:19:24 INFO - [mozharness: 2017-06-09 23:19:24.539807Z] Finished populate-webroot step (success) 16:19:24 INFO - [mozharness: 2017-06-09 23:19:24.539896Z] Running create-virtualenv step. 16:19:24 INFO - Running pre-action listener: _resource_record_pre_action 16:19:24 INFO - Running main action method: create_virtualenv 16:19:24 INFO - Creating virtualenv /builds/slave/test/build/venv 16:19:24 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 16:19:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:19:24 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:19:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:19:24 INFO - Using real prefix '/usr' 16:19:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:19:25 INFO - Installing distribute.............................................................................................................................................................................................done. 16:19:27 INFO - Installing pip.................done. 16:19:27 INFO - Return code: 0 16:19:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:19:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:19:27 INFO - Reading from file tmpfile_stdout 16:19:27 INFO - Output received: 16:19:27 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) 16:19:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:19: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')]} 16:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19: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')]} 16:19:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10df3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b140>, '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 0x145ba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145bed0>, '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': 'db0483c52d987ecb441a263b000001ad-1497038885.99686-1458522901', '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 16:19: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', 'pip>=1.5'] in /builds/slave/test/build 16:19: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 pip>=1.5 16:19:27 INFO - Using env: {'DISPLAY': ':0', 16:19:27 INFO - 'HOME': '/home/cltbld', 16:19:27 INFO - 'LANG': 'en_US.UTF-8', 16:19:27 INFO - 'LANGUAGE': 'en_US:en', 16:19:27 INFO - 'LOGNAME': 'cltbld', 16:19:27 INFO - 'MAIL': '/var/mail/cltbld', 16:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:27 INFO - 'MOZ_NO_REMOTE': '1', 16:19:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:27 INFO - 'NO_EM_RESTART': '1', 16:19:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:27 INFO - 'PWD': '/builds/slave/test', 16:19:27 INFO - 'SHELL': '/bin/bash', 16:19:27 INFO - 'SHLVL': '1', 16:19:27 INFO - 'TERM': 'linux', 16:19:27 INFO - 'TMOUT': '86400', 16:19:27 INFO - 'USER': 'cltbld', 16:19:27 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1497038885.99686-1458522901', 16:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:27 INFO - '_': '/tools/buildbot/bin/python'} 16:19:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:27 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 16:19:27 INFO - Cleaning up... 16:19:27 INFO - Return code: 0 16:19:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:19: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')]} 16:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19: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')]} 16:19:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19: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', '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 0x10df3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b140>, '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 0x145ba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145bed0>, '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': 'db0483c52d987ecb441a263b000001ad-1497038885.99686-1458522901', '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 16:19: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', 'psutil>=3.1.1'] in /builds/slave/test/build 16:19: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 psutil>=3.1.1 16:19:27 INFO - Using env: {'DISPLAY': ':0', 16:19:27 INFO - 'HOME': '/home/cltbld', 16:19:27 INFO - 'LANG': 'en_US.UTF-8', 16:19:27 INFO - 'LANGUAGE': 'en_US:en', 16:19:27 INFO - 'LOGNAME': 'cltbld', 16:19:27 INFO - 'MAIL': '/var/mail/cltbld', 16:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:27 INFO - 'MOZ_NO_REMOTE': '1', 16:19:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:27 INFO - 'NO_EM_RESTART': '1', 16:19:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:27 INFO - 'PWD': '/builds/slave/test', 16:19:27 INFO - 'SHELL': '/bin/bash', 16:19:27 INFO - 'SHLVL': '1', 16:19:27 INFO - 'TERM': 'linux', 16:19:27 INFO - 'TMOUT': '86400', 16:19:27 INFO - 'USER': 'cltbld', 16:19:27 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1497038885.99686-1458522901', 16:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:27 INFO - '_': '/tools/buildbot/bin/python'} 16:19:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:27 INFO - Downloading/unpacking psutil>=3.1.1 16:19: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 16:19: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 16:19: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 16:19: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 16:19:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:19:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:19:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:19:29 INFO - Installing collected packages: psutil 16:19:29 INFO - Running setup.py install for psutil 16:19:29 INFO - building 'psutil._psutil_linux' extension 16:19:29 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 16:19:30 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 16:19:30 INFO - building 'psutil._psutil_posix' extension 16:19:30 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 16:19:30 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 16:19:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:19:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:19:30 INFO - Successfully installed psutil 16:19:30 INFO - Cleaning up... 16:19:30 INFO - Return code: 0 16:19:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:19:30 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')]} 16:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:30 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')]} 16:19:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:30 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 0x10df3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b140>, '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 0x145ba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145bed0>, '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': 'db0483c52d987ecb441a263b000001ad-1497038885.99686-1458522901', '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 16:19:30 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 16:19:30 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 16:19:30 INFO - Using env: {'DISPLAY': ':0', 16:19:30 INFO - 'HOME': '/home/cltbld', 16:19:30 INFO - 'LANG': 'en_US.UTF-8', 16:19:30 INFO - 'LANGUAGE': 'en_US:en', 16:19:30 INFO - 'LOGNAME': 'cltbld', 16:19:30 INFO - 'MAIL': '/var/mail/cltbld', 16:19:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:30 INFO - 'MOZ_NO_REMOTE': '1', 16:19:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:30 INFO - 'NO_EM_RESTART': '1', 16:19:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:30 INFO - 'PWD': '/builds/slave/test', 16:19:30 INFO - 'SHELL': '/bin/bash', 16:19:30 INFO - 'SHLVL': '1', 16:19:30 INFO - 'TERM': 'linux', 16:19:30 INFO - 'TMOUT': '86400', 16:19:30 INFO - 'USER': 'cltbld', 16:19:30 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1497038885.99686-1458522901', 16:19:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:30 INFO - '_': '/tools/buildbot/bin/python'} 16:19:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:19:30 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 16:19:30 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 16:19:30 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 16:19:30 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 16:19:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:19:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:19:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:19:32 INFO - Installing collected packages: mozsystemmonitor 16:19:32 INFO - Running setup.py install for mozsystemmonitor 16:19:32 INFO - Successfully installed mozsystemmonitor 16:19:32 INFO - Cleaning up... 16:19:32 INFO - Return code: 0 16:19:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:19: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')]} 16:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19: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')]} 16:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:32 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 0x10df3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b140>, '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 0x145ba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145bed0>, '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': 'db0483c52d987ecb441a263b000001ad-1497038885.99686-1458522901', '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 16:19:32 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 16:19:32 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 16:19:32 INFO - Using env: {'DISPLAY': ':0', 16:19:32 INFO - 'HOME': '/home/cltbld', 16:19:32 INFO - 'LANG': 'en_US.UTF-8', 16:19:32 INFO - 'LANGUAGE': 'en_US:en', 16:19:32 INFO - 'LOGNAME': 'cltbld', 16:19:32 INFO - 'MAIL': '/var/mail/cltbld', 16:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:32 INFO - 'MOZ_NO_REMOTE': '1', 16:19:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:32 INFO - 'NO_EM_RESTART': '1', 16:19:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:32 INFO - 'PWD': '/builds/slave/test', 16:19:32 INFO - 'SHELL': '/bin/bash', 16:19:32 INFO - 'SHLVL': '1', 16:19:32 INFO - 'TERM': 'linux', 16:19:32 INFO - 'TMOUT': '86400', 16:19:32 INFO - 'USER': 'cltbld', 16:19:32 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1497038885.99686-1458522901', 16:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:32 INFO - '_': '/tools/buildbot/bin/python'} 16:19:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:32 INFO - Downloading/unpacking jsonschema==2.5.1 16:19:32 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 16:19:32 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 16:19:32 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 16:19:32 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 16:19:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:19:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:19:33 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 16:19:33 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 16:19:33 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 16:19:33 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 16:19:33 INFO - Downloading functools32-3.2.3-2.tar.gz 16:19:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:19:33 INFO - warning: no files found matching '*.txt' 16:19:33 INFO - no previously-included directories found matching 'build' 16:19:33 INFO - no previously-included directories found matching 'dist' 16:19:33 INFO - no previously-included directories found matching '.git*' 16:19:33 INFO - Installing collected packages: jsonschema, functools32 16:19:33 INFO - Running setup.py install for functools32 16:19:33 INFO - warning: no files found matching '*.txt' 16:19:33 INFO - no previously-included directories found matching 'build' 16:19:33 INFO - no previously-included directories found matching 'dist' 16:19:33 INFO - no previously-included directories found matching '.git*' 16:19:33 INFO - Successfully installed jsonschema functools32 16:19:33 INFO - Cleaning up... 16:19:33 INFO - Return code: 0 16:19:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:19:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:33 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 0x10df3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b140>, '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 0x145ba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145bed0>, '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': 'db0483c52d987ecb441a263b000001ad-1497038885.99686-1458522901', '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 16:19:33 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 16:19:33 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 16:19:33 INFO - Using env: {'DISPLAY': ':0', 16:19:33 INFO - 'HOME': '/home/cltbld', 16:19:33 INFO - 'LANG': 'en_US.UTF-8', 16:19:33 INFO - 'LANGUAGE': 'en_US:en', 16:19:33 INFO - 'LOGNAME': 'cltbld', 16:19:33 INFO - 'MAIL': '/var/mail/cltbld', 16:19:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:33 INFO - 'MOZ_NO_REMOTE': '1', 16:19:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:33 INFO - 'NO_EM_RESTART': '1', 16:19:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:33 INFO - 'PWD': '/builds/slave/test', 16:19:33 INFO - 'SHELL': '/bin/bash', 16:19:33 INFO - 'SHLVL': '1', 16:19:33 INFO - 'TERM': 'linux', 16:19:33 INFO - 'TMOUT': '86400', 16:19:33 INFO - 'USER': 'cltbld', 16:19:33 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1497038885.99686-1458522901', 16:19:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:33 INFO - '_': '/tools/buildbot/bin/python'} 16:19:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:19:34 INFO - Cleaning up... 16:19:34 INFO - Return code: 0 16:19:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:19:34 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')]} 16:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:34 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')]} 16:19:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:34 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 0x10df3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b140>, '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 0x145ba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145bed0>, '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': 'db0483c52d987ecb441a263b000001ad-1497038885.99686-1458522901', '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 16:19:34 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 16:19:34 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 16:19:34 INFO - Using env: {'DISPLAY': ':0', 16:19:34 INFO - 'HOME': '/home/cltbld', 16:19:34 INFO - 'LANG': 'en_US.UTF-8', 16:19:34 INFO - 'LANGUAGE': 'en_US:en', 16:19:34 INFO - 'LOGNAME': 'cltbld', 16:19:34 INFO - 'MAIL': '/var/mail/cltbld', 16:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:34 INFO - 'MOZ_NO_REMOTE': '1', 16:19:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:34 INFO - 'NO_EM_RESTART': '1', 16:19:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:34 INFO - 'PWD': '/builds/slave/test', 16:19:34 INFO - 'SHELL': '/bin/bash', 16:19:34 INFO - 'SHLVL': '1', 16:19:34 INFO - 'TERM': 'linux', 16:19:34 INFO - 'TMOUT': '86400', 16:19:34 INFO - 'USER': 'cltbld', 16:19:34 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1497038885.99686-1458522901', 16:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:34 INFO - '_': '/tools/buildbot/bin/python'} 16:19:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:34 INFO - Downloading/unpacking blobuploader==1.2.4 16:19:34 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 16:19:34 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 16:19:34 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 16:19:34 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 16:19:35 INFO - Downloading blobuploader-1.2.4.tar.gz 16:19:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:19:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:19:35 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 16:19:35 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 16:19:35 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 16:19:35 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 16:19:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:19:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:19:35 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 16:19:35 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 16:19:35 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 16:19:35 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 16:19:35 INFO - Downloading docopt-0.6.1.tar.gz 16:19:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:19:36 INFO - Installing collected packages: blobuploader, requests, docopt 16:19:36 INFO - Running setup.py install for blobuploader 16:19:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:19:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:19:36 INFO - Running setup.py install for requests 16:19:36 INFO - Running setup.py install for docopt 16:19:36 INFO - Successfully installed blobuploader requests docopt 16:19:36 INFO - Cleaning up... 16:19:36 INFO - Return code: 0 16:19:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:19:36 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')]} 16:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:36 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')]} 16:19:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:36 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 0x10df3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b140>, '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 0x145ba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145bed0>, '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': 'db0483c52d987ecb441a263b000001ad-1497038885.99686-1458522901', '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 16:19:36 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 16:19:36 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 16:19:36 INFO - Using env: {'DISPLAY': ':0', 16:19:36 INFO - 'HOME': '/home/cltbld', 16:19:36 INFO - 'LANG': 'en_US.UTF-8', 16:19:36 INFO - 'LANGUAGE': 'en_US:en', 16:19:36 INFO - 'LOGNAME': 'cltbld', 16:19:36 INFO - 'MAIL': '/var/mail/cltbld', 16:19:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:36 INFO - 'MOZ_NO_REMOTE': '1', 16:19:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:36 INFO - 'NO_EM_RESTART': '1', 16:19:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:36 INFO - 'PWD': '/builds/slave/test', 16:19:36 INFO - 'SHELL': '/bin/bash', 16:19:36 INFO - 'SHLVL': '1', 16:19:36 INFO - 'TERM': 'linux', 16:19:36 INFO - 'TMOUT': '86400', 16:19:36 INFO - 'USER': 'cltbld', 16:19:36 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1497038885.99686-1458522901', 16:19:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:36 INFO - '_': '/tools/buildbot/bin/python'} 16:19:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:19:36 INFO - Running setup.py (path:/tmp/pip-DoUZV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:19:36 INFO - Running setup.py (path:/tmp/pip-L68uT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:19:36 INFO - Running setup.py (path:/tmp/pip-zwcMjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:19:37 INFO - Running setup.py (path:/tmp/pip-ybmAGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:19:37 INFO - Running setup.py (path:/tmp/pip-BRc3ik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:19:37 INFO - Running setup.py (path:/tmp/pip-2NqpfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:19:37 INFO - Running setup.py (path:/tmp/pip-FG6MEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:19:37 INFO - Running setup.py (path:/tmp/pip-DaIQWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:19:37 INFO - Running setup.py (path:/tmp/pip-C88JUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:19:37 INFO - Running setup.py (path:/tmp/pip-A1Y8z6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:19:37 INFO - Running setup.py (path:/tmp/pip-LHda7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:19:37 INFO - Running setup.py (path:/tmp/pip-BkB2rd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:19:37 INFO - Running setup.py (path:/tmp/pip-evuIG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:19:37 INFO - Running setup.py (path:/tmp/pip-V2dk0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:19:37 INFO - Running setup.py (path:/tmp/pip-nYBu_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:19:37 INFO - Running setup.py (path:/tmp/pip-dlSXDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:19:37 INFO - Running setup.py (path:/tmp/pip-gReJTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:19:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:19:38 INFO - Running setup.py install for manifestparser 16:19:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:19:38 INFO - Running setup.py install for mozcrash 16:19:38 INFO - Running setup.py install for mozdebug 16:19:38 INFO - Running setup.py install for mozdevice 16:19:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:19:38 INFO - Running setup.py install for mozfile 16:19:38 INFO - Running setup.py install for mozhttpd 16:19:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:19:38 INFO - Running setup.py install for mozinfo 16:19:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:19:38 INFO - Running setup.py install for mozInstall 16:19:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:19:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:19:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:19:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:19:38 INFO - Running setup.py install for mozleak 16:19:38 INFO - Running setup.py install for mozlog 16:19:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:19:39 INFO - Running setup.py install for moznetwork 16:19:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:19:39 INFO - Running setup.py install for mozprocess 16:19:39 INFO - Running setup.py install for mozprofile 16:19:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:19:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:19:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:19:39 INFO - Running setup.py install for mozrunner 16:19:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:19:39 INFO - Running setup.py install for mozscreenshot 16:19:39 INFO - Running setup.py install for moztest 16:19:39 INFO - Running setup.py install for mozversion 16:19:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:19:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:19:39 INFO - Cleaning up... 16:19:39 INFO - Return code: 0 16:19:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:19:39 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')]} 16:19:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:39 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')]} 16:19:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:39 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 0x10df3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b140>, '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 0x145ba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145bed0>, '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': 'db0483c52d987ecb441a263b000001ad-1497038885.99686-1458522901', '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 16:19:39 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 16:19:39 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 16:19:39 INFO - Using env: {'DISPLAY': ':0', 16:19:39 INFO - 'HOME': '/home/cltbld', 16:19:39 INFO - 'LANG': 'en_US.UTF-8', 16:19:39 INFO - 'LANGUAGE': 'en_US:en', 16:19:39 INFO - 'LOGNAME': 'cltbld', 16:19:39 INFO - 'MAIL': '/var/mail/cltbld', 16:19:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:39 INFO - 'MOZ_NO_REMOTE': '1', 16:19:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:39 INFO - 'NO_EM_RESTART': '1', 16:19:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:39 INFO - 'PWD': '/builds/slave/test', 16:19:39 INFO - 'SHELL': '/bin/bash', 16:19:39 INFO - 'SHLVL': '1', 16:19:39 INFO - 'TERM': 'linux', 16:19:39 INFO - 'TMOUT': '86400', 16:19:39 INFO - 'USER': 'cltbld', 16:19:39 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1497038885.99686-1458522901', 16:19:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:39 INFO - '_': '/tools/buildbot/bin/python'} 16:19:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:19:40 INFO - Running setup.py (path:/tmp/pip-MtUV0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:19:40 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)) 16:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:19:40 INFO - Running setup.py (path:/tmp/pip-yThTSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:19:40 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)) 16:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:19:40 INFO - Running setup.py (path:/tmp/pip-N7N6sT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:19:40 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)) 16:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:19:40 INFO - Running setup.py (path:/tmp/pip-qPqEGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:19:40 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)) 16:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:19:40 INFO - Running setup.py (path:/tmp/pip-4NnHoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:19:40 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)) 16:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:19:40 INFO - Running setup.py (path:/tmp/pip-vuPLrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:19:40 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)) 16:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:19:40 INFO - Running setup.py (path:/tmp/pip-sOY2mC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:19:40 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)) 16:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:19:40 INFO - Running setup.py (path:/tmp/pip-cAaXdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:19:40 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)) 16:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:19:40 INFO - Running setup.py (path:/tmp/pip-PVryuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:19:40 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)) 16:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:19:40 INFO - Running setup.py (path:/tmp/pip-N7Sc1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:19:40 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)) 16:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:19:40 INFO - Running setup.py (path:/tmp/pip-XgvbZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:19:40 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)) 16:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:19:40 INFO - Running setup.py (path:/tmp/pip-K84phq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:19:40 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)) 16:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:19:40 INFO - Running setup.py (path:/tmp/pip-TGxqBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:19:40 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)) 16:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:19:40 INFO - Running setup.py (path:/tmp/pip-qRjbj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:19:41 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)) 16:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:19:41 INFO - Running setup.py (path:/tmp/pip-YkPBpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:19:41 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)) 16:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:19:41 INFO - Running setup.py (path:/tmp/pip-24S4e9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:19:41 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)) 16:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:19:41 INFO - Running setup.py (path:/tmp/pip-A0_AVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:19:41 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)) 16:19:41 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)) 16:19:41 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)) 16:19:41 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)) 16:19:41 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)) 16:19:41 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)) 16:19:41 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)) 16:19:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:19:41 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 16:19:41 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 16:19:41 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 16:19:41 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 16:19:42 INFO - Downloading blessings-1.6.tar.gz 16:19:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:19:42 INFO - Installing collected packages: blessings 16:19:42 INFO - Running setup.py install for blessings 16:19:42 INFO - Successfully installed blessings 16:19:42 INFO - Cleaning up... 16:19:42 INFO - Return code: 0 16:19:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:19:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:19:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:19:42 INFO - Reading from file tmpfile_stdout 16:19:42 INFO - Current package versions: 16:19:42 INFO - argparse == 1.2.1 16:19:42 INFO - blessings == 1.6 16:19:42 INFO - blobuploader == 1.2.4 16:19:42 INFO - docopt == 0.6.1 16:19:42 INFO - functools32 == 3.2.3-2 16:19:42 INFO - jsonschema == 2.5.1 16:19:42 INFO - manifestparser == 1.1 16:19:42 INFO - mozInstall == 1.13 16:19:42 INFO - mozcrash == 1.0 16:19:42 INFO - mozdebug == 0.1 16:19:42 INFO - mozdevice == 0.51 16:19:42 INFO - mozfile == 1.2 16:19:42 INFO - mozhttpd == 0.7 16:19:42 INFO - mozinfo == 0.10 16:19:42 INFO - mozleak == 0.1 16:19:42 INFO - mozlog == 3.4 16:19:42 INFO - moznetwork == 0.27 16:19:42 INFO - mozprocess == 0.25 16:19:42 INFO - mozprofile == 0.28 16:19:42 INFO - mozrunner == 6.13 16:19:42 INFO - mozscreenshot == 0.1 16:19:42 INFO - mozsystemmonitor == 0.3 16:19:42 INFO - moztest == 0.8 16:19:42 INFO - mozversion == 1.4 16:19:42 INFO - psutil == 3.1.1 16:19:42 INFO - requests == 1.2.3 16:19:42 INFO - wsgiref == 0.1.2 16:19:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:19:42 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')]} 16:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:42 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')]} 16:19:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:42 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 0x10df3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b140>, '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 0x145ba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145bed0>, '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': 'db0483c52d987ecb441a263b000001ad-1497038885.99686-1458522901', '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 16:19:42 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 16:19:42 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 16:19:42 INFO - Using env: {'DISPLAY': ':0', 16:19:42 INFO - 'HOME': '/home/cltbld', 16:19:42 INFO - 'LANG': 'en_US.UTF-8', 16:19:42 INFO - 'LANGUAGE': 'en_US:en', 16:19:42 INFO - 'LOGNAME': 'cltbld', 16:19:42 INFO - 'MAIL': '/var/mail/cltbld', 16:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:42 INFO - 'MOZ_NO_REMOTE': '1', 16:19:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:42 INFO - 'NO_EM_RESTART': '1', 16:19:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:42 INFO - 'PWD': '/builds/slave/test', 16:19:42 INFO - 'SHELL': '/bin/bash', 16:19:42 INFO - 'SHLVL': '1', 16:19:42 INFO - 'TERM': 'linux', 16:19:42 INFO - 'TMOUT': '86400', 16:19:42 INFO - 'USER': 'cltbld', 16:19:42 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1497038885.99686-1458522901', 16:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:42 INFO - '_': '/tools/buildbot/bin/python'} 16:19:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:42 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)) 16:19:42 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)) 16:19:42 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)) 16:19:42 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)) 16:19:42 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)) 16:19:42 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)) 16:19:42 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)) 16:19:42 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)) 16:19:42 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)) 16:19:42 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:19:42 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 16:19:42 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 16:19:42 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 16:19:42 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 16:19:44 INFO - Downloading marionette_driver-1.4.0.tar.gz 16:19:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 16:19:44 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)) 16:19:44 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)) 16:19:44 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)) 16:19:44 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)) 16:19:44 INFO - Installing collected packages: marionette-driver 16:19:44 INFO - Running setup.py install for marionette-driver 16:19:44 INFO - Successfully installed marionette-driver 16:19:44 INFO - Cleaning up... 16:19:44 INFO - Return code: 0 16:19:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:19:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10df3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b140>, '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 0x145ba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145bed0>, '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': 'db0483c52d987ecb441a263b000001ad-1497038885.99686-1458522901', '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 16:19:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:19:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:19:44 INFO - Using env: {'DISPLAY': ':0', 16:19:44 INFO - 'HOME': '/home/cltbld', 16:19:44 INFO - 'LANG': 'en_US.UTF-8', 16:19:44 INFO - 'LANGUAGE': 'en_US:en', 16:19:44 INFO - 'LOGNAME': 'cltbld', 16:19:44 INFO - 'MAIL': '/var/mail/cltbld', 16:19:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:44 INFO - 'MOZ_NO_REMOTE': '1', 16:19:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:44 INFO - 'NO_EM_RESTART': '1', 16:19:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:44 INFO - 'PWD': '/builds/slave/test', 16:19:44 INFO - 'SHELL': '/bin/bash', 16:19:44 INFO - 'SHLVL': '1', 16:19:44 INFO - 'TERM': 'linux', 16:19:44 INFO - 'TMOUT': '86400', 16:19:44 INFO - 'USER': 'cltbld', 16:19:44 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1497038885.99686-1458522901', 16:19:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:44 INFO - '_': '/tools/buildbot/bin/python'} 16:19:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:19:44 INFO - Cleaning up... 16:19:44 INFO - Return code: 0 16:19:44 INFO - Running post-action listener: _resource_record_post_action 16:19:44 INFO - Running post-action listener: _start_resource_monitoring 16:19:44 INFO - Starting resource monitoring. 16:19:44 INFO - [mozharness: 2017-06-09 23:19:44.546232Z] Finished create-virtualenv step (success) 16:19:44 INFO - [mozharness: 2017-06-09 23:19:44.547179Z] Running install step. 16:19:44 INFO - Running pre-action listener: _resource_record_pre_action 16:19:44 INFO - Running main action method: install 16:19:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:19:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:19:44 INFO - Reading from file tmpfile_stdout 16:19:44 INFO - Detecting whether we're running mozinstall >=1.0... 16:19:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:19:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:19:44 INFO - Reading from file tmpfile_stdout 16:19:44 INFO - Output received: 16:19:44 INFO - Usage: mozinstall [options] installer 16:19:44 INFO - Options: 16:19:44 INFO - -h, --help show this help message and exit 16:19:44 INFO - -d DEST, --destination=DEST 16:19:44 INFO - Directory to install application into. [default: 16:19:44 INFO - "/builds/slave/test"] 16:19:44 INFO - --app=APP Application being installed. [default: firefox] 16:19:44 INFO - mkdir: /builds/slave/test/build/application 16:19:44 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'] 16:19:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:20:02 INFO - Reading from file tmpfile_stdout 16:20:02 INFO - Output received: 16:20:02 INFO - /builds/slave/test/build/application/firefox/firefox 16:20:02 INFO - Running post-action listener: _resource_record_post_action 16:20:02 INFO - [mozharness: 2017-06-09 23:20:02.024300Z] Finished install step (success) 16:20:02 INFO - [mozharness: 2017-06-09 23:20:02.024580Z] Running setup-mitmproxy step. 16:20:02 INFO - Running pre-action listener: _resource_record_pre_action 16:20:02 INFO - Running main action method: setup_mitmproxy 16:20:02 INFO - Skipping: mitmproxy is not required 16:20:02 INFO - Running post-action listener: _resource_record_post_action 16:20:02 INFO - [mozharness: 2017-06-09 23:20:02.025825Z] Finished setup-mitmproxy step (success) 16:20:02 INFO - [mozharness: 2017-06-09 23:20:02.026049Z] Running run-tests step. 16:20:02 INFO - Running pre-action listener: _resource_record_pre_action 16:20:02 INFO - Running main action method: run_tests 16:20:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:20:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:20:02 INFO - Python 2.7.3 16:20:02 INFO - Return code: 0 16:20:02 INFO - grabbing minidump binary from tooltool 16:20:02 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')]} 16:20:02 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 0x145b140>, '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 0x145ba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145bed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:20:02 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 16:20:02 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 16:20:02 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 16:20:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:20:02 INFO - Return code: 0 16:20:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:20:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:20:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:20:02 INFO - ENV: RUST_BACKTRACE is now 1 16:20:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:20:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:20:02 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/WOD1aXL-Re-nV13fq7Zfhg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 16:20:02 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/WOD1aXL-Re-nV13fq7Zfhg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 16:20:02 INFO - Using env: {'DISPLAY': ':0', 16:20:02 INFO - 'HOME': '/home/cltbld', 16:20:02 INFO - 'LANG': 'en_US.UTF-8', 16:20:02 INFO - 'LANGUAGE': 'en_US:en', 16:20:02 INFO - 'LOGNAME': 'cltbld', 16:20:02 INFO - 'MAIL': '/var/mail/cltbld', 16:20:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:20:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:20:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:02 INFO - 'MOZ_NO_REMOTE': '1', 16:20:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:20:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:02 INFO - 'NO_EM_RESTART': '1', 16:20:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:02 INFO - 'PWD': '/builds/slave/test', 16:20:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:20:02 INFO - 'RUST_BACKTRACE': '1', 16:20:02 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:20:02 INFO - 'SHELL': '/bin/bash', 16:20:02 INFO - 'SHLVL': '1', 16:20:02 INFO - 'TERM': 'linux', 16:20:02 INFO - 'TMOUT': '86400', 16:20:02 INFO - 'USER': 'cltbld', 16:20:02 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1497038885.99686-1458522901', 16:20:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:02 INFO - '_': '/tools/buildbot/bin/python'} 16:20:02 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/WOD1aXL-Re-nV13fq7Zfhg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 16:20:02 INFO - mozversion application_buildid: 20170609224820 16:20:02 INFO - mozversion application_changeset: c4e74cfbf7e9d8e297e214478d25e3456f858cea 16:20:02 INFO - mozversion application_display_name: Nightly 16:20:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:20:02 INFO - mozversion application_name: Firefox 16:20:02 INFO - mozversion application_remotingname: firefox 16:20:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:20:02 INFO - mozversion application_vendor: Mozilla 16:20:02 INFO - mozversion application_version: 55.0a1 16:20:02 INFO - mozversion platform_buildid: 20170609224820 16:20:02 INFO - mozversion platform_changeset: c4e74cfbf7e9d8e297e214478d25e3456f858cea 16:20:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:20:02 INFO - mozversion platform_version: 55.0a1 16:20:02 INFO - using testdate: 1497050402 16:20:02 INFO - actual date: 1497050402 16:20:02 INFO - starting webserver on 'localhost:52613' 16:20:02 INFO - SUITE-START | Running 2 tests 16:20:02 INFO - TEST-START | dromaeo_css 16:20:02 INFO - operating with platform_type : linux_ 16:20:02 INFO - Initialising browser for dromaeo_css test... 16:20:02 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52613/getInfo.html -profile /tmp/tmpJFMcZH/profile 16:20:02 INFO - TEST-INFO | started process 3359 (/builds/slave/test/build/application/firefox/firefox http://localhost:52613/getInfo.html) 16:20:38 INFO - TEST-INFO | 3359: killed by SIGTERM 16:20:39 INFO - Browser initialized. 16:20:39 INFO - Running cycle 1/1 for dromaeo_css test... 16:20:39 INFO - TEST-INFO | started process 3564 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJFMcZH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:20:50 INFO - PID 3564 | RSS: Main: 184594432 16:20:50 INFO - PID 3564 | 16:23:51 INFO - PID 3564 | Cycle 1(1): loaded http://localhost:52613/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52613/tests/dromaeo/cssquery-ext.html) 16:23:52 INFO - PID 3564 | RSS: Main: 180056064 16:23:52 INFO - PID 3564 | 16:26:54 INFO - PID 3564 | Cycle 1(1): loaded http://localhost:52613/tests/dromaeo/cssquery-ext.html (next: http://localhost:52613/tests/dromaeo/cssquery-jquery.html) 16:26:55 INFO - PID 3564 | RSS: Main: 184926208 16:26:55 INFO - PID 3564 | 16:29:56 INFO - PID 3564 | Cycle 1(1): loaded http://localhost:52613/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52613/tests/dromaeo/cssquery-mootools.html) 16:29:57 INFO - PID 3564 | RSS: Main: 183025664 16:29:57 INFO - PID 3564 | 16:32:59 INFO - PID 3564 | Cycle 1(1): loaded http://localhost:52613/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52613/tests/dromaeo/cssquery-prototype.html) 16:32:59 INFO - PID 3564 | RSS: Main: 186441728 16:32:59 INFO - PID 3564 | 16:36:02 INFO - PID 3564 | Cycle 1(1): loaded http://localhost:52613/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52613/tests/dromaeo/cssquery-yui.html) 16:36:03 INFO - PID 3564 | RSS: Main: 184872960 16:36:03 INFO - PID 3564 | 16:39:04 INFO - PID 3564 | Cycle 1(1): loaded http://localhost:52613/tests/dromaeo/cssquery-yui.html (next: http://localhost:52613/tests/dromaeo/cssquery-dojo.html) 16:39:05 INFO - PID 3564 | RSS: Main: 187088896 16:39:05 INFO - PID 3564 | 16:39:05 INFO - PID 3564 | __start_tp_report 16:39:05 INFO - PID 3564 | _x_x_mozilla_page_load 16:39:05 INFO - PID 3564 | _x_x_mozilla_page_load_details 16:39:05 INFO - PID 3564 | |i|pagename|runs| 16:39:05 INFO - PID 3564 | |0;dojo.html;3062.6018617579716;3101;3107.9067627971167;3109.5802066720985;3126.7967582107162;5837;5862.73617687204;5917.88164236715;6027.849303767408;6031.879362412755;5881.67650779207;5967.612105213158;5970.194023806785;5971.731272092756;6061.272647282332;5381.81163659272;5494.532964698005;5524.8342549723375;5526.47498487643;5543.501084902358;5588.832335029955;5598.4961353478175;5616.85957851055;5625.6905870177125;5631.521320687726;5421.647592906448;5449.782008719647;5504.889902201953;5515.4760297771645;5524.254225679522;5489.752961116759;5509.173623956399;5547.639403438763;5592.412796656374;5603.991281569316;5492.340919089735;5506.311711036121;5521.420250873641;5526.253955715967;5533.529649979716;5787.797427090031;5864.501517371029;5956.315023772278;5974.790882319141;5981.282246130449;6395.968020159869;6513.739450421977;6514.315996820313;6528.21661400635;6545.705443255018;6547.377999090078;6551.246606640202;6557.114789503451;6566.835829104263;6567.277599464055;5863.589548731547;6052.303985041688;6067.969660151715;6077.665728384893;6083.087536869505;6576.4410025147445;6602.8349291268105;6690.632015239208;6694.966525167343;6706.530542861953;6031.517478601701;6083.209182806296;6116.731440059295;6376.458001069868;6381.425671689477;6461.386168314003;6461.741530338828;6463.256725476536;6465.4827613790785;6488.708008139645;6296.811095667137;6381.425671689571;6448.935510644834;6464.159659244268;6478.255000674889;6338.271098823694;6356.4279214870885;6379.138816259839;6402.647854368054;6438.163038804925;5302.867428314245;5324.866878328073;5328.040952628564;5331.040412725747;5331.626786125012;4506.301523263899;4511.751853648081;4523.231050721385;4526.162659907927;4542.364069030338;5395.568354531628;5454.863628409322;5467.043267428184;5535.667859928417;5550.944490555124;6549.541532092708;6563.1796025496815;6564.80305590833;6566;6568.540202185896;5578.776848926079;5579.6652200868075;5585;5592.328920529481;5619.129034999582;5584.21820945068;5652.349979752299;5708.086706127;5775.5090817281;5805.709714514257;6268.341824108403;6274.749010039639;6295.748170073146;6297.937020629826;6306.621602703853;6460.741570337133;6490.377405648588;6499.5125365598715;6532.575382600306;6535.901961470487;6144.600600960924;6292.748290068346;6296.181496405438;6306.779262725782;6319.115323854756;6234.937650623617;6280.7487700491465;6313.494920406265;6338.968305158444;6339.778107766206;6560.803175904731;6577.80266592003;6582.539222254396;6586.077949087227;6597.637129957899;5918.17145599625;6092.055731361646;6121.173641558333;6200.968995155175;6318.652474113784;6329.746810127727;6330.335314792064;6331.2085989251345;6347.460465860454;6351.777687780906;6099.298580663103;6117.357677443804;6151.446369826737;6167.136600875791;6269.31037585856;6284.4344009039405;6301.369863013845;6344.9048264277;6352.777652782131;6389.9680501597195;6175.505959523317;6175.536834737502;6180.351063138485;6189.288231853215;6191.876162476815 16:39:05 INFO - PID 3564 | |1;ext.html;741.2994719989612;788.298414411174;800.8198155415032;1164.1036401970482;1176.041526156182;34489.65510344896;36181;36250.456243156375;36292;36294.27411451773;38402;38580.614193858055;38815.41776873349;38833.417498737545;38923.416148757795;7155.642217889111;7281.9271807281775;7375.299346562095;7400.296971787671;7411.036565246511;7369.115706115247;7405.296496832819;7450.962745186266;7453.180150183475;7456.105267367923;7346.889796653055;7426.405887529012;7458.4033277337685;7475.401967842587;7483.9896613957235;7370.705171793122;7405.518641288299;7406.9629651851665;7439.665215065281;7451.403887688972;7271.454640901953;7272.272772722738;7283.308085731847;7310.049693539859;7340.96329518349;34813.30373392518;35087.4736878947;35168.648313516795;35216.471752923724;35244.118897027525;3356.9664303357144;3395.6774106459848;3397.184675677844;3397.3545026445145;3404.897853064412;27403.72596274032;27522.862385687942;27588.172354829185;27590;27634.032808851796;3360.1095709636966;3366.309906469168;3403.9659603403898;3411.385950528904;3412.436947903593;129654;134643;134668;163175.18412407863;163931.9999999988;38136;38286;38357.424638630444;38373.424398633484;38408.42387364192;39999.60000400017;40128.39807402891;40193.79903100524;40317.193656126714;40390.39414408786;14477.131372117707;14519.78220326696;14571.271436428136;14574.052686575338;14668.926655366655;12032.03743700502;12115;12124.333161676192;12174.634760957186;12188.20776649515;13666.726665466835;13673.042886998013;13708.012338210903;13734.65663358404;13833.308334583231;5768.567357448124;5837.956715149664;5863.560232982543;5893.764249430061;5909.261342332208;1007.4912169354576;1011.6610935336597;1017.765913839821;1025.5692609104194;1032.3444612670858;21499.42006959175;22014.779852201595;22215.44461388478;22628.321150365515;22752.431189220402;1082.4749996251812;1085.7068591480256;1113.7939481196004;1118.3848883114254;1126.1553834624033;11847.407629618485;11934.462949167308;12123.515059397701;12211.206271592318;12817.35913204336;196945;197081;197650;198266;199354;48968.02063958701;49399.753001235484;49580.50419495831;49610.75194624004;49632.75183624059;1410.8448070712213;1464.7729601911722;1477.7709455034487;1481.9259037047889;1482.05148704829;20630.828983499254;21061.368158955254;22228.777712222673;22277.8087205601;22556.774432255468;33882.83058584691;35122.297554048266;35405;35541.466877997365;35723.82138089293;169541;169719;170165.04422345158;171419.14290428467;172738;27437;27777.861110694317;29264.975725849494;30540.694593054675;31749.841250793597;36121.63878361183;36230.637693622724;36760.448593271656;36979.63020369762;37311.44032839564;27482.17553473319;27515.86242068777;27980;28539.714602853706;28764.85617571899;26890.596641050008;27748.722512774613;28039;28237.15288541347;28485.43029139447;30212.09363719092;30841.537376939814;30851.074467766004;30903.69096309008;31092.844535777178;26438.867805660848;26487.518252903898;27260.591091134047;27432.314192145357;28154.2961425966;21770.564588708454;22436.551268974854;22469.325920222418;22585.30610204274;22767.544649106592 16:39:05 INFO - PID 3564 | |2;jquery.html;467.376052969286;479.6522521172151;480.65873230006696;488.9535494128058;503.12958581653737;14732;15404.460843870467;20522.692159617618;21226.257081002168;21237.469063273405;21488.570228595418;22161.66757498639;22305.330840074785;22306.553868922612;22399.55200895981;5976.611520251192;6127.540434467411;6173.660448675321;6174.135621013062;6185.845353866144;5945.672987985659;6018.3981601839905;6056.242969628796;6066.363031881655;6067.393260673919;5554.1113421852515;5805.303363596375;5889.823305300848;5987.970060149693;5997.910031349533;5838.357780644125;5920.97039514804;5924.644521328734;5925.081612350093;5931.051031834929;5422.6475279106735;5426.701531415771;5432.809851655213;5439.93921185369;5444.5916556258435;23803;23807.88096059526;23831.165909193096;23879.88060059706;24042;1911.1972971352066;1954.5797653504565;1962.3622322745023;1964.9508762280914;1973.1712680674152;15941.202939853078;17116.572085697833;17127.57181070483;17143.571410714707;17161.14194290293;2156.8813715245656;2159.902804373807;2214.7895949884737;2226.265332440307;2227.4208705736464;105006;105889;106265.46867265615;106495;106700;11851.288922664668;12626.30555319448;12752.298623575607;14256.215908124945;14257.714845703027;19100.33148839812;19113.139908704143;19117.522061948563;19325.323613673452;19339.12973916177;8781.165789250012;8886.911130888737;8931.106889311146;8975.147361000694;8985.955070224607;8227.794305142299;8330.291925186428;8349.582520873932;8357.206065423776;8419.326453883674;7892.9210707893335;8047.879281810778;8052.235037671529;8079.515229086273;8195.549244791475;2177.825773938081;2181.2801775414077;2219.55608878225;2287.9199228026937;2308.607536718762;940.3558562384652;963.1524258652341;973.8661204876285;997.2670087485692;998.2912132386087;18354.357597484024;18684.53288667767;19053.333133340268;20577.794222057586;22683.430249866247;968.8788901387327;1001.8296889528798;1017.760826205841;1027.635189507729;1045.9320144190604;10002.449865257335;10336.741581460374;10533.210009249337;10566.260361774755;10653.520591573399;409887;412903;413277;415516;420971;94103;95274;96143.51928240314;96583;96694.51652741691;1223.590097317391;1242.1739543203848;1245.875412458765;1247.8065899785547;1256.5225214418463;15841.128737919526;18594.535136621693;20437.182512699324;20468.590628187056;20849.791502084787;48821.53535393944;49612.503874960785;50003;50819;50870.745646271534;57983;58245.417545824;58591.121133183886;58617.12074318974;58734.70632646809;11220.831687524857;11441.942790285995;11553.13351498624;11557.88442115568;11563.595274165364;16747.665046699243;17871.553211169823;17942.19260133271;18156.45530634083;18322.450326490227;14682.486112985995;14751.188684622448;14767.92616036956;14772.113673179643;14786.704265914837;13694.65763355924;13851.653708657364;14030.438782448997;14059.507917222849;14233.928830355782;14726.63183420423;14784.408623655363;14797.630059248175;15255.313510891814;15554.688906221585;11293.887061129612;11332.150088743541;11387.54449822031;11437.771244575228;11486.597969071043;14154.50459233963;14217.786733198804;14249;14250.572482825532;14269.286535672967 16:39:05 INFO - PID 3564 | |3;mootools.html;1290.348374071094;1315.8617795606797;1351.2770667692773;1354.3702178487008;1377.5522955039614;11516.309021458708;11838.171328007022;12178.269303841764;12194.451249693762;12282.263064216153;11982.340971246578;12122.515099396014;12156.27062376258;12177.269363838175;12210.145289829716;2480.516299321633;2505.361132911105;2506.0226511660467;2531.493701259746;2539.771420572148;2434.3427274635837;2503.7371076036934;2504.6743923289946;2508.598624220125;2511.3470497670646;2432.19737486629;2450.9387265318333;2463.938401539958;2466.703995520531;2468.8395254308502;2311.9884400577976;2360.84654497458;2376.584097782881;2383.547126046063;2388.6536452214505;2295.4490922178725;2358.4929240213437;2365.988170059156;2450.3016640257442;2457.410221546834;11885.584004559885;11994.580189693406;12001.51993920242;12001.519939202508;12003.759924801456;6558.475321974231;6826.522143449961;6831;6839.0425340452375;6844.076049733322;3917.392804115338;4125.793710314502;4192.559781222989;4228.238916994939;4233.618974292298;1404.3329418526118;1405.7329107469548;1408.1058527834796;1438.2161721861505;1454.7454195515847;16684.165791710366;17128.400505982354;18120;18242.817571824377;18245.54386140344;5699.088145896637;5759.107338362561;5880.7944371403755;5922.437368449991;5944.138099975479;13688.384022719001;13704.3833027514;13809;13847.376868040963;13852.722945541032;6476.417122459001;6724.125863637696;6733.494987875929;6734.259231484532;6739.764108256286;6198.938010619926;6233.906491402633;6269.435750782452;6277.027060805583;6315.778947736807;4491.214037543482;4602.424696912886;4605.102005109038;4642.187617166982;4658.324542941255;1353.1204716934071;1360.3266383140408;1368.8836448901955;1378.7725025370903;1387.3826147364325;834.8956380452444;849.541247726221;853.3898262742046;872.6029656506274;889.7731078574922;6601.174853143357;6601.900971485432;6671.499637527205;6789.694463749143;6888.207856096513;669.0766741896249;695.6035060015743;706.3819158236543;712.6294326949957;714.3999040805749;4041.454403655469;4106;4157.064660451435;4219.852305169305;4233.978830105892;15240.314185861664;15804.841951580567;15809.525714228592;15814.68370632581;15868.841311586737;15513.689726205639;15692.68614627724;15765.08647505288;15934.60163495922;16327.265273062503;9391.530423478798;9717.076877696607;9989.150922171697;9992.450415227233;9994.950025249973;6761.290064543152;7099.396551293198;7459.738909138154;7516.210797866145;7632.5038872473115;14339;14371.496997605034;14456.2049087297;14580.125192488485;14627.488037918622;14484.565463036126;14597.343119559433;14638.414463421344;14664.340104695528;14790.11259324444;10095.192384609067;10139.645112421325;10253.641122560675;10257.128144107535;10339.63811266602;11272.154588406067;11453.713657158638;11453.828192576952;11457.59898403552;11466.31202127875;9267.258619310303;9498.335116541775;9526.52367381642;9728.027197280499;9807.85288220663;9142.954285228798;9151.450912945245;9165.633374665205;9343.112404321579;9571;8385.161483851565;8460.323174145931;8519.403641745019;8563.186497282748;8573.314134869071;6088.178095956989;6183.876322473436;6371.87256254863;6483.870322593616;6612;6307.05394190875;6392.52056095804;6560.40956313934;6681.899771503334;6782.423494003065 16:39:05 INFO - PID 3564 | |4;prototype.html;441.94033805436266;460.82488654311356;461.95842374186316;473.64949937046595;475.70743992444636;6104.816855494331;6338.9049164262515;6356.968215158918;6367.904481432776;6376.150916234286;5960.79137230197;6128.816135515931;6132.632042077478;6135.907961380572;6160.414760597747;4787.13831510328;4922.80308787648;4932.284818701304;4936.703797772145;4958.652894297401;4979.551840334369;4990.775415106311;4991.575716064139;4997.875053123683;5003.74981250936;4914.901701965977;4931.605471562267;4931.605471562267;4932.865440948584;4943.505649435064;4907.484714105021;4918.852434426973;4930.80276788928;4947.975260123712;4952.504749525055;4367.8114976067645;4369.497507786614;4382.342648602703;4387.934180987288;4397.604215620578;6116.357782432825;6155.907661385083;6163.352847950945;6164.445199932027;6174.876502469971;5642.7742890284335;5658.886822263573;5660.66036037835;5665.051695719478;5707.571932105067;6560.606363618198;6578.6381749003785;6583.967080164616;6595.340465953414;6610.0745895574655;4793.544613261734;4794.736289504076;4794.856154315376;4797.9520204797855;4799.880002999953;6529.510286728514;6898.793036208922;6915.827104322432;6939.965300173517;6983.406410455117;4775.164346239464;4849.75751212445;4862.635302352338;4862.805487780449;4865.343178670834;4885.413750349981;4905.264210368473;4911.287863259808;4917.164082106051;4928.408590969107;5394.217838413408;5589.245451864028;5595.132754423071;5601.719914004283;5610.541259272619;6516.739330426824;6556.409923106943;6573.474122070223;6610.338966103447;6615.702293396808;1695.3472912928612;1715.7254839225664;1722.190570431895;1725.3098760495902;1729.2564197394988;1108.257467496779;1161.6456980620992;1172.783035138502;1187.0978056676815;1191.2614179208947;5727.914081288784;5755.647422855625;5780.624259423124;5783.132530120515;5830.766769329264;6803.795886123424;6820.147481564804;6827.419669328064;6845.247022827485;6860.5197636164985;5722.484976352148;5735.627184233012;5751;5751.338596061423;5782;3607.8196090195383;3625.492431059654;3629.6007439181667;3634.47300141478;3635.600083990759;6549.476041916635;6594.637294948728;6620.139381880324;6636.900446493307;6638.838203314401;6856.314368563104;6876.553024053421;6910.170779506391;6953.6440394122665;6954.478414118961;6374.904376434357;6488.480921526267;6553;6612.5040621952585;6620.172478440195;6750.2237242715755;6758.42553382968;6796.320367963164;6801.421879140328;6833.145856767904;6715.697793599202;6775.661216939035;6779.694913728796;6783.626900520321;6786.423154031962;6156.5998210116195;6473.77341793035;6544.738210471718;6556.147700798866;6607.9669601651685;5266.683998960075;5327.8299411849885;5333.653312534673;5334.1732031535175;5351.1973204019705;6481.222253329631;6750.831229219309;6779.15260592426;6782.457403407814;6812.671529051788;6545.443637290884;6575;6577.868442631217;6578.506612004023;6600.108985287116;6556;6563.540552161494;6570.145881035626;6621.106150669598;6664.566803157779;6437.034444833125;6451.677416129269;6488.805335839932;6550.508711846535;6556.492006838549;6635;6640.169978752656;6653.63405012729;6662.500312476487;6662.83342916431;6402.167718196604;6444.581102228341;6445.16212892321;6446.226452825691;6472.385123413268 16:39:05 INFO - PID 3564 | |5;yui.html;796.4703472190994;810.266708628691;811.5455345006793;825.1088824070004;825.7605294464602;15167.848321516782;15604.999999999985;15617;17465.388711395102;19002.334918277862;17403.651926961455;18519.351822686207;18876.339328123486;18899.811001889975;18900;967.9467629280387;992.5731935267831;993.3940296419179;994.9900500995006;997.1175509673918;944.3955868244329;981.5337714585586;997.0478193325393;1001.9749506262328;1004.0712341084504;1063.059192614534;1063.0857462582173;1063.415121683075;1064.7391389109641;1064.9893501065008;1050.333038520541;1054.4147997861185;1055.208593554834;1055.8996895294936;1056.2922841696081;764.7820371194183;766.1457474915485;772.1082150116624;774.1329710724025;774.4540099230029;13475.528356507573;15892;16038.75941860873;16050.678986420324;16087.678246435124;17520.737188942177;17523.47429577102;17780.555486112822;18038;18042.729359059624;14321;14645.780313295309;14646.267686615627;14648.560543183721;14672.926635366755;3392.1858753899132;3395.5925288965236;3403.7957722536726;3404.591449026108;3421.0934102462866;74348.62825685837;76272;77084;77576.61211693905;78442.6077869607;13618.387172577257;14153.433862645585;14180.716385672229;14260.786088208684;14313.21277329736;22469.325920222418;22745.658815117786;22954.081836726677;22973.081076756742;22980.310590682308;7991.920080799234;8176.959115204386;8271.090180080186;8363.080061193265;8371.204735550113;3976.423418604344;4060.1879624075304;4060.715749897538;4063.553009168989;4079.7756123413496;4373.540778218305;4380.3210502372185;4467.329900514948;4499.617532509773;4535.0249696314795;851.1360968616859;853.4964371021127;866.2766589897507;866.3026263857529;869.7347309070668;682.9453643708491;685.9108315918899;704.2183176673888;705.4074577355046;726.3644311227675;10562;11055.170862185369;11209.887901121048;11582.47878845454;11826.526938922347;681.5672048249298;686.6703982088626;701.2846896165883;710.7761055267574;712.2877122877123;5170.087067784943;5305.973470132624;5434.266374039533;5446.291982042309;5533.114701647797;90729;91425.54287228521;92758;93286.53356733173;94548.52725736327;70555.6472217646;71846.281537185;72484;72684.2731572688;72820;63384.36615633877;63481.36518634847;63938.99999999907;64274;65075.67462162659;11537.769244615229;12149.271043737404;12162.513499459923;12298.81551776742;12429.12996090265;28249;28483.145505634864;28490.43019139564;28650.856745716137;29009.854950725112;35728.64271357357;36075;36344;36815.81592092022;37237.62762372341;15454.072755634697;15658.21708914527;15829.366825326859;15862.286197120926;16046.518604441886;17701.29194832244;17917;18132.18405171744;18465.076746162908;18571.44285671432;16332.59168520749;16335.428260010842;16407.343706251617;16557.58606034859;16711.91644041772;16026.358945642043;16429.753553696464;16505;16577.088260145807;16745.24646390891;14833.851661483248;15122;15176;15188.164650943861;15473.458428954933;11267.887321126684;11306.378149201873;11609.361485118061;11679.474423651127;12194.268343899394;12692;12987;13634.250116243702;13719.657008574866;13927.164370137823 16:39:05 INFO - PID 3564 | __end_tp_report 16:39:05 INFO - PID 3564 | __start_cc_report 16:39:05 INFO - PID 3564 | _x_x_mozilla_cycle_collect,396 16:39:05 INFO - PID 3564 | __end_cc_report 16:39:05 INFO - PID 3564 | __startTimestamp1497051545083__endTimestamp 16:39:05 INFO - PID 3564 | 16:39:05 INFO - PID 3564 | ------- Summary: start ------- 16:39:05 INFO - PID 3564 | Number of tests: 6 16:39:05 INFO - PID 3564 | 16:39:05 INFO - PID 3564 | [#0] dojo.html Cycles:165 Average:5941.11 Median:6121.17 stddev:691.96 (11.3%) stddev-sans-first:656.20 16:39:05 INFO - PID 3564 | Values: 3062.6 3101.0 3107.9 3109.6 3126.8 5837.0 5862.7 5917.9 6027.8 6031.9 5881.7 5967.6 5970.2 5971.7 6061.3 5381.8 5494.5 5524.8 5526.5 5543.5 5588.8 5598.5 5616.9 5625.7 5631.5 5421.6 5449.8 5504.9 5515.5 5524.3 5489.8 5509.2 5547.6 5592.4 5604.0 5492.3 5506.3 5521.4 5526.3 5533.5 5787.8 5864.5 5956.3 5974.8 5981.3 6396.0 6513.7 6514.3 6528.2 6545.7 6547.4 6551.2 6557.1 6566.8 6567.3 5863.6 6052.3 6068.0 6077.7 6083.1 6576.4 6602.8 6690.6 6695.0 6706.5 6031.5 6083.2 6116.7 6376.5 6381.4 6461.4 6461.7 6463.3 6465.5 6488.7 6296.8 6381.4 6448.9 6464.2 6478.3 6338.3 6356.4 6379.1 6402.6 6438.2 5302.9 5324.9 5328.0 5331.0 5331.6 4506.3 4511.8 4523.2 4526.2 4542.4 5395.6 5454.9 5467.0 5535.7 5550.9 6549.5 6563.2 6564.8 6566.0 6568.5 5578.8 5579.7 5585.0 5592.3 5619.1 5584.2 5652.3 5708.1 5775.5 5805.7 6268.3 6274.7 6295.7 6297.9 6306.6 6460.7 6490.4 6499.5 6532.6 6535.9 6144.6 6292.7 6296.2 6306.8 6319.1 6234.9 6280.7 6313.5 6339.0 6339.8 6560.8 6577.8 6582.5 6586.1 6597.6 5918.2 6092.1 6121.2 6201.0 6318.7 6329.7 6330.3 6331.2 6347.5 6351.8 6099.3 6117.4 6151.4 6167.1 6269.3 6284.4 6301.4 6344.9 6352.8 6390.0 6175.5 6175.5 6180.4 6189.3 6191.9 16:39:05 INFO - PID 3564 | 16:39:05 INFO - PID 3564 | [#1] ext.html Cycles:180 Average:32419.18 Median:30376.39 stddev:44620.49 (146.9%) stddev-sans-first:44682.26 16:39:05 INFO - PID 3564 | Values: 741.3 788.3 800.8 1164.1 1176.0 34489.7 36181.0 36250.5 36292.0 36294.3 38402.0 38580.6 38815.4 38833.4 38923.4 7155.6 7281.9 7375.3 7400.3 7411.0 7369.1 7405.3 7451.0 7453.2 7456.1 7346.9 7426.4 7458.4 7475.4 7484.0 7370.7 7405.5 7407.0 7439.7 7451.4 7271.5 7272.3 7283.3 7310.0 7341.0 34813.3 35087.5 35168.6 35216.5 35244.1 3357.0 3395.7 3397.2 3397.4 3404.9 27403.7 27522.9 27588.2 27590.0 27634.0 3360.1 3366.3 3404.0 3411.4 3412.4 129654.0 134643.0 134668.0 163175.2 163932.0 38136.0 38286.0 38357.4 38373.4 38408.4 39999.6 40128.4 40193.8 40317.2 40390.4 14477.1 14519.8 14571.3 14574.1 14668.9 12032.0 12115.0 12124.3 12174.6 12188.2 13666.7 13673.0 13708.0 13734.7 13833.3 5768.6 5838.0 5863.6 5893.8 5909.3 1007.5 1011.7 1017.8 1025.6 1032.3 21499.4 22014.8 22215.4 22628.3 22752.4 1082.5 1085.7 1113.8 1118.4 1126.2 11847.4 11934.5 12123.5 12211.2 12817.4 196945.0 197081.0 197650.0 198266.0 199354.0 48968.0 49399.8 49580.5 49610.8 49632.8 1410.8 1464.8 1477.8 1481.9 1482.1 20630.8 21061.4 22228.8 22277.8 22556.8 33882.8 35122.3 35405.0 35541.5 35723.8 169541.0 169719.0 170165.0 171419.1 172738.0 27437.0 27777.9 29265.0 30540.7 31749.8 36121.6 36230.6 36760.4 36979.6 37311.4 27482.2 27515.9 27980.0 28539.7 28764.9 26890.6 27748.7 28039.0 28237.2 28485.4 30212.1 30841.5 30851.1 30903.7 31092.8 26438.9 26487.5 27260.6 27432.3 28154.3 21770.6 22436.6 22469.3 22585.3 22767.5 16:39:05 INFO - PID 3564 | 16:39:05 INFO - PID 3564 | [#2] jquery.html Cycles:180 Average:29210.95 Median:2168.86 stddev:69395.14 (3199.6%) stddev-sans-first:69556.25 16:39:05 INFO - PID 3564 | Values: 467.4 479.7 480.7 489.0 503.1 14732.0 15404.5 20522.7 21226.3 21237.5 21488.6 22161.7 22305.3 22306.6 22399.6 5976.6 6127.5 6173.7 6174.1 6185.8 5945.7 6018.4 6056.2 6066.4 6067.4 5554.1 5805.3 5889.8 5988.0 5997.9 5838.4 5921.0 5924.6 5925.1 5931.1 5422.6 5426.7 5432.8 5439.9 5444.6 23803.0 23807.9 23831.2 23879.9 24042.0 1911.2 1954.6 1962.4 1965.0 1973.2 15941.2 17116.6 17127.6 17143.6 17161.1 2156.9 2159.9 2214.8 2226.3 2227.4 105006.0 105889.0 106265.5 106495.0 106700.0 11851.3 12626.3 12752.3 14256.2 14257.7 19100.3 19113.1 19117.5 19325.3 19339.1 8781.2 8886.9 8931.1 8975.1 8986.0 8227.8 8330.3 8349.6 8357.2 8419.3 7892.9 8047.9 8052.2 8079.5 8195.5 2177.8 2181.3 2219.6 2287.9 2308.6 940.4 963.2 973.9 997.3 998.3 18354.4 18684.5 19053.3 20577.8 22683.4 968.9 1001.8 1017.8 1027.6 1045.9 10002.4 10336.7 10533.2 10566.3 10653.5 409887.0 412903.0 413277.0 415516.0 420971.0 94103.0 95274.0 96143.5 96583.0 96694.5 1223.6 1242.2 1245.9 1247.8 1256.5 15841.1 18594.5 20437.2 20468.6 20849.8 48821.5 49612.5 50003.0 50819.0 50870.7 57983.0 58245.4 58591.1 58617.1 58734.7 11220.8 11441.9 11553.1 11557.9 11563.6 16747.7 17871.6 17942.2 18156.5 18322.5 14682.5 14751.2 14767.9 14772.1 14786.7 13694.7 13851.7 14030.4 14059.5 14233.9 14726.6 14784.4 14797.6 15255.3 15554.7 11293.9 11332.2 11387.5 11437.8 11486.6 14154.5 14217.8 14249.0 14250.6 14269.3 16:39:05 INFO - PID 3564 | 16:39:05 INFO - PID 3564 | [#3] mootools.html Cycles:180 Average:7507.89 Median:2507.31 stddev:4870.21 (194.2%) stddev-sans-first:4861.47 16:39:05 INFO - PID 3564 | Values: 1290.3 1315.9 1351.3 1354.4 1377.6 11516.3 11838.2 12178.3 12194.5 12282.3 11982.3 12122.5 12156.3 12177.3 12210.1 2480.5 2505.4 2506.0 2531.5 2539.8 2434.3 2503.7 2504.7 2508.6 2511.3 2432.2 2450.9 2463.9 2466.7 2468.8 2312.0 2360.8 2376.6 2383.5 2388.7 2295.4 2358.5 2366.0 2450.3 2457.4 11885.6 11994.6 12001.5 12001.5 12003.8 6558.5 6826.5 6831.0 6839.0 6844.1 3917.4 4125.8 4192.6 4228.2 4233.6 1404.3 1405.7 1408.1 1438.2 1454.7 16684.2 17128.4 18120.0 18242.8 18245.5 5699.1 5759.1 5880.8 5922.4 5944.1 13688.4 13704.4 13809.0 13847.4 13852.7 6476.4 6724.1 6733.5 6734.3 6739.8 6198.9 6233.9 6269.4 6277.0 6315.8 4491.2 4602.4 4605.1 4642.2 4658.3 1353.1 1360.3 1368.9 1378.8 1387.4 834.9 849.5 853.4 872.6 889.8 6601.2 6601.9 6671.5 6789.7 6888.2 669.1 695.6 706.4 712.6 714.4 4041.5 4106.0 4157.1 4219.9 4234.0 15240.3 15804.8 15809.5 15814.7 15868.8 15513.7 15692.7 15765.1 15934.6 16327.3 9391.5 9717.1 9989.2 9992.5 9995.0 6761.3 7099.4 7459.7 7516.2 7632.5 14339.0 14371.5 14456.2 14580.1 14627.5 14484.6 14597.3 14638.4 14664.3 14790.1 10095.2 10139.6 10253.6 10257.1 10339.6 11272.2 11453.7 11453.8 11457.6 11466.3 9267.3 9498.3 9526.5 9728.0 9807.9 9143.0 9151.5 9165.6 9343.1 9571.0 8385.2 8460.3 8519.4 8563.2 8573.3 6088.2 6183.9 6371.9 6483.9 6612.0 6307.1 6392.5 6560.4 6681.9 6782.4 16:39:05 INFO - PID 3564 | 16:39:05 INFO - PID 3564 | [#4] prototype.html Cycles:180 Average:5519.50 Median:6145.91 stddev:1576.70 (25.7%) stddev-sans-first:1534.38 16:39:05 INFO - PID 3564 | Values: 441.9 460.8 462.0 473.6 475.7 6104.8 6338.9 6357.0 6367.9 6376.2 5960.8 6128.8 6132.6 6135.9 6160.4 4787.1 4922.8 4932.3 4936.7 4958.7 4979.6 4990.8 4991.6 4997.9 5003.7 4914.9 4931.6 4931.6 4932.9 4943.5 4907.5 4918.9 4930.8 4948.0 4952.5 4367.8 4369.5 4382.3 4387.9 4397.6 6116.4 6155.9 6163.4 6164.4 6174.9 5642.8 5658.9 5660.7 5665.1 5707.6 6560.6 6578.6 6584.0 6595.3 6610.1 4793.5 4794.7 4794.9 4798.0 4799.9 6529.5 6898.8 6915.8 6940.0 6983.4 4775.2 4849.8 4862.6 4862.8 4865.3 4885.4 4905.3 4911.3 4917.2 4928.4 5394.2 5589.2 5595.1 5601.7 5610.5 6516.7 6556.4 6573.5 6610.3 6615.7 1695.3 1715.7 1722.2 1725.3 1729.3 1108.3 1161.6 1172.8 1187.1 1191.3 5727.9 5755.6 5780.6 5783.1 5830.8 6803.8 6820.1 6827.4 6845.2 6860.5 5722.5 5735.6 5751.0 5751.3 5782.0 3607.8 3625.5 3629.6 3634.5 3635.6 6549.5 6594.6 6620.1 6636.9 6638.8 6856.3 6876.6 6910.2 6953.6 6954.5 6374.9 6488.5 6553.0 6612.5 6620.2 6750.2 6758.4 6796.3 6801.4 6833.1 6715.7 6775.7 6779.7 6783.6 6786.4 6156.6 6473.8 6544.7 6556.1 6608.0 5266.7 5327.8 5333.7 5334.2 5351.2 6481.2 6750.8 6779.2 6782.5 6812.7 6545.4 6575.0 6577.9 6578.5 6600.1 6556.0 6563.5 6570.1 6621.1 6664.6 6437.0 6451.7 6488.8 6550.5 6556.5 6635.0 6640.2 6653.6 6662.5 6662.8 6402.2 6444.6 6445.2 6446.2 6472.4 16:39:05 INFO - PID 3564 | 16:39:05 INFO - PID 3564 | [#5] yui.html Cycles:180 Average:18170.84 Median:22976.70 stddev:22556.29 (98.2%) stddev-sans-first:22581.83 16:39:05 INFO - PID 3564 | Values: 796.5 810.3 811.5 825.1 825.8 15167.8 15605.0 15617.0 17465.4 19002.3 17403.7 18519.4 18876.3 18899.8 18900.0 967.9 992.6 993.4 995.0 997.1 944.4 981.5 997.0 1002.0 1004.1 1063.1 1063.1 1063.4 1064.7 1065.0 1050.3 1054.4 1055.2 1055.9 1056.3 764.8 766.1 772.1 774.1 774.5 13475.5 15892.0 16038.8 16050.7 16087.7 17520.7 17523.5 17780.6 18038.0 18042.7 14321.0 14645.8 14646.3 14648.6 14672.9 3392.2 3395.6 3403.8 3404.6 3421.1 74348.6 76272.0 77084.0 77576.6 78442.6 13618.4 14153.4 14180.7 14260.8 14313.2 22469.3 22745.7 22954.1 22973.1 22980.3 7991.9 8177.0 8271.1 8363.1 8371.2 3976.4 4060.2 4060.7 4063.6 4079.8 4373.5 4380.3 4467.3 4499.6 4535.0 851.1 853.5 866.3 866.3 869.7 682.9 685.9 704.2 705.4 726.4 10562.0 11055.2 11209.9 11582.5 11826.5 681.6 686.7 701.3 710.8 712.3 5170.1 5306.0 5434.3 5446.3 5533.1 90729.0 91425.5 92758.0 93286.5 94548.5 70555.6 71846.3 72484.0 72684.3 72820.0 63384.4 63481.4 63939.0 64274.0 65075.7 11537.8 12149.3 12162.5 12298.8 12429.1 28249.0 28483.1 28490.4 28650.9 29009.9 35728.6 36075.0 36344.0 36815.8 37237.6 15454.1 15658.2 15829.4 15862.3 16046.5 17701.3 17917.0 18132.2 18465.1 18571.4 16332.6 16335.4 16407.3 16557.6 16711.9 16026.4 16429.8 16505.0 16577.1 16745.2 14833.9 15122.0 15176.0 15188.2 15473.5 11267.9 11306.4 11609.4 11679.5 12194.3 12692.0 12987.0 13634.3 13719.7 13927.2 16:39:05 INFO - PID 3564 | -------- Summary: end -------- 16:39:05 INFO - PID 3564 | 16:39:06 INFO - TEST-INFO | 3564: exit 0 16:39:06 INFO - TEST-OK | dromaeo_css | took 1143265ms 16:39:06 INFO - TEST-START | kraken 16:39:06 INFO - operating with platform_type : linux_ 16:39:06 INFO - Initialising browser for kraken test... 16:39:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52613/getInfo.html -profile /tmp/tmpCfBCZT/profile 16:39:06 INFO - TEST-INFO | started process 3970 (/builds/slave/test/build/application/firefox/firefox http://localhost:52613/getInfo.html) 16:39:40 INFO - TEST-INFO | 3970: killed by SIGTERM 16:39:40 INFO - Browser initialized. 16:39:40 INFO - Running cycle 1/1 for kraken test... 16:39:40 INFO - TEST-INFO | started process 4180 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCfBCZT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:39:52 INFO - PID 4180 | RSS: Main: 184463360 16:39:52 INFO - PID 4180 | 16:39:54 INFO - PID 4180 | Cycle 1(1): loaded http://localhost:52613/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52613/tests/kraken/driver.html?testName=audio-beat-detection) 16:39:55 INFO - PID 4180 | RSS: Main: 189517824 16:39:55 INFO - PID 4180 | 16:39:58 INFO - PID 4180 | Cycle 1(1): loaded http://localhost:52613/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52613/tests/kraken/driver.html?testName=audio-dft) 16:39:59 INFO - PID 4180 | RSS: Main: 188579840 16:39:59 INFO - PID 4180 | 16:40:02 INFO - PID 4180 | Cycle 1(1): loaded http://localhost:52613/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52613/tests/kraken/driver.html?testName=audio-fft) 16:40:02 INFO - PID 4180 | RSS: Main: 183881728 16:40:02 INFO - PID 4180 | 16:40:04 INFO - PID 4180 | Cycle 1(1): loaded http://localhost:52613/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52613/tests/kraken/driver.html?testName=audio-oscillator) 16:40:05 INFO - PID 4180 | RSS: Main: 184741888 16:40:05 INFO - PID 4180 | 16:40:07 INFO - PID 4180 | Cycle 1(1): loaded http://localhost:52613/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52613/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:40:08 INFO - PID 4180 | RSS: Main: 184647680 16:40:08 INFO - PID 4180 | 16:40:11 INFO - PID 4180 | Cycle 1(1): loaded http://localhost:52613/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52613/tests/kraken/driver.html?testName=imaging-darkroom) 16:40:12 INFO - PID 4180 | RSS: Main: 186576896 16:40:12 INFO - PID 4180 | 16:40:15 INFO - PID 4180 | Cycle 1(1): loaded http://localhost:52613/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52613/tests/kraken/driver.html?testName=imaging-desaturate) 16:40:16 INFO - PID 4180 | RSS: Main: 184979456 16:40:16 INFO - PID 4180 | 16:40:18 INFO - PID 4180 | Cycle 1(1): loaded http://localhost:52613/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52613/tests/kraken/driver.html?testName=json-parse-financial) 16:40:19 INFO - PID 4180 | RSS: Main: 185851904 16:40:19 INFO - PID 4180 | 16:40:21 INFO - PID 4180 | Cycle 1(1): loaded http://localhost:52613/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52613/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:40:21 INFO - PID 4180 | RSS: Main: 185638912 16:40:21 INFO - PID 4180 | 16:40:23 INFO - PID 4180 | Cycle 1(1): loaded http://localhost:52613/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52613/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:40:24 INFO - PID 4180 | RSS: Main: 185339904 16:40:24 INFO - PID 4180 | 16:40:26 INFO - PID 4180 | Cycle 1(1): loaded http://localhost:52613/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52613/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:40:27 INFO - PID 4180 | RSS: Main: 185569280 16:40:27 INFO - PID 4180 | 16:40:29 INFO - PID 4180 | Cycle 1(1): loaded http://localhost:52613/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52613/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:40:30 INFO - PID 4180 | RSS: Main: 185671680 16:40:30 INFO - PID 4180 | 16:40:33 INFO - PID 4180 | Cycle 1(1): loaded http://localhost:52613/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52613/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:40:34 INFO - PID 4180 | RSS: Main: 185528320 16:40:34 INFO - PID 4180 | 16:40:35 INFO - PID 4180 | Cycle 1(1): loaded http://localhost:52613/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52613/tests/kraken/driver.html?testName=ai-astar) 16:40:36 INFO - PID 4180 | RSS: Main: 186941440 16:40:36 INFO - PID 4180 | 16:40:36 INFO - PID 4180 | __start_tp_report 16:40:36 INFO - PID 4180 | _x_x_mozilla_page_load 16:40:36 INFO - PID 4180 | _x_x_mozilla_page_load_details 16:40:36 INFO - PID 4180 | |i|pagename|runs| 16:40:36 INFO - PID 4180 | |0;ai-astar;102;109;102;111;110;111;112;101;111;112 16:40:36 INFO - PID 4180 | |1;audio-beat-detection;154;124;153;184;120;150;153;125;164;122 16:40:36 INFO - PID 4180 | |2;audio-dft;162;165;165;161;166;164;168;169;167;162 16:40:36 INFO - PID 4180 | |3;audio-fft;76;74;73;186;74;77;77;77;168;74 16:40:36 INFO - PID 4180 | |4;audio-oscillator;83;83;131;84;82;84;132;83;82;132 16:40:36 INFO - PID 4180 | |5;imaging-gaussian-blur;114;115;113;114;114;113;113;114;114;114 16:40:36 INFO - PID 4180 | |6;imaging-darkroom;150;151;150;149;151;150;150;151;149;151 16:40:36 INFO - PID 4180 | |7;imaging-desaturate;94;95;94;95;94;95;96;95;95;95 16:40:36 INFO - PID 4180 | |8;json-parse-financial;58;55;58;54;56;55;56;54;55;58 16:40:36 INFO - PID 4180 | |9;json-stringify-tinderbox;56;56;55;56;56;55;56;56;55;55 16:40:36 INFO - PID 4180 | |10;stanford-crypto-aes;82;82;82;82;82;85;82;98;103;84 16:40:36 INFO - PID 4180 | |11;stanford-crypto-ccm;146;130;132;132;133;130;130;146;139;134 16:40:36 INFO - PID 4180 | |12;stanford-crypto-pbkdf2;188;190;201;186;197;183;178;187;192;179 16:40:36 INFO - PID 4180 | |13;stanford-crypto-sha256-iterative;70;71;75;71;73;69;72;71;78;70 16:40:36 INFO - PID 4180 | __end_tp_report 16:40:36 INFO - PID 4180 | __start_cc_report 16:40:36 INFO - PID 4180 | _x_x_mozilla_cycle_collect,1004 16:40:36 INFO - PID 4180 | __end_cc_report 16:40:36 INFO - PID 4180 | __startTimestamp1497051636120__endTimestamp 16:40:36 INFO - PID 4180 | 16:40:36 INFO - PID 4180 | ------- Summary: start ------- 16:40:36 INFO - PID 4180 | Number of tests: 14 16:40:36 INFO - PID 4180 | 16:40:36 INFO - PID 4180 | [#0] ai-astar Cycles:10 Average:108.10 Median:111.00 stddev:4.53 (4.1%) stddev-sans-first:4.24 16:40:36 INFO - PID 4180 | Values: 102.0 109.0 102.0 111.0 110.0 111.0 112.0 101.0 111.0 112.0 16:40:36 INFO - PID 4180 | 16:40:36 INFO - PID 4180 | [#1] audio-beat-detection Cycles:10 Average:144.90 Median:153.00 stddev:21.37 (14.0%) stddev-sans-first:22.41 16:40:36 INFO - PID 4180 | Values: 154.0 124.0 153.0 184.0 120.0 150.0 153.0 125.0 164.0 122.0 16:40:36 INFO - PID 4180 | 16:40:36 INFO - PID 4180 | [#2] audio-dft Cycles:10 Average:164.90 Median:165.50 stddev:2.69 (1.6%) stddev-sans-first:2.64 16:40:36 INFO - PID 4180 | Values: 162.0 165.0 165.0 161.0 166.0 164.0 168.0 169.0 167.0 162.0 16:40:36 INFO - PID 4180 | 16:40:36 INFO - PID 4180 | [#3] audio-fft Cycles:10 Average:95.60 Median:75.00 stddev:43.14 (57.5%) stddev-sans-first:45.17 16:40:36 INFO - PID 4180 | Values: 76.0 74.0 73.0 186.0 74.0 77.0 77.0 77.0 168.0 74.0 16:40:36 INFO - PID 4180 | 16:40:36 INFO - PID 4180 | [#4] audio-oscillator Cycles:10 Average:97.60 Median:83.00 stddev:23.52 (28.3%) stddev-sans-first:24.35 16:40:36 INFO - PID 4180 | Values: 83.0 83.0 131.0 84.0 82.0 84.0 132.0 83.0 82.0 132.0 16:40:36 INFO - PID 4180 | 16:40:36 INFO - PID 4180 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 16:40:36 INFO - PID 4180 | Values: 114.0 115.0 113.0 114.0 114.0 113.0 113.0 114.0 114.0 114.0 16:40:36 INFO - PID 4180 | 16:40:36 INFO - PID 4180 | [#6] imaging-darkroom Cycles:10 Average:150.20 Median:150.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 16:40:36 INFO - PID 4180 | Values: 150.0 151.0 150.0 149.0 151.0 150.0 150.0 151.0 149.0 151.0 16:40:36 INFO - PID 4180 | 16:40:36 INFO - PID 4180 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 16:40:36 INFO - PID 4180 | Values: 94.0 95.0 94.0 95.0 94.0 95.0 96.0 95.0 95.0 95.0 16:40:36 INFO - PID 4180 | 16:40:36 INFO - PID 4180 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:1.60 (2.8%) stddev-sans-first:1.50 16:40:36 INFO - PID 4180 | Values: 58.0 55.0 58.0 54.0 56.0 55.0 56.0 54.0 55.0 58.0 16:40:36 INFO - PID 4180 | 16:40:36 INFO - PID 4180 | [#9] json-stringify-tinderbox Cycles:10 Average:55.60 Median:56.00 stddev:0.52 (0.9%) stddev-sans-first:0.53 16:40:36 INFO - PID 4180 | Values: 56.0 56.0 55.0 56.0 56.0 55.0 56.0 56.0 55.0 55.0 16:40:36 INFO - PID 4180 | 16:40:36 INFO - PID 4180 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:82.00 stddev:7.70 (9.4%) stddev-sans-first:8.02 16:40:36 INFO - PID 4180 | Values: 82.0 82.0 82.0 82.0 82.0 85.0 82.0 98.0 103.0 84.0 16:40:36 INFO - PID 4180 | 16:40:36 INFO - PID 4180 | [#11] stanford-crypto-ccm Cycles:10 Average:135.20 Median:133.50 stddev:6.29 (4.7%) stddev-sans-first:5.32 16:40:36 INFO - PID 4180 | Values: 146.0 130.0 132.0 132.0 133.0 130.0 130.0 146.0 139.0 134.0 16:40:36 INFO - PID 4180 | 16:40:36 INFO - PID 4180 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.10 Median:189.00 stddev:7.31 (3.9%) stddev-sans-first:7.75 16:40:36 INFO - PID 4180 | Values: 188.0 190.0 201.0 186.0 197.0 183.0 178.0 187.0 192.0 179.0 16:40:36 INFO - PID 4180 | 16:40:36 INFO - PID 4180 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:71.50 stddev:2.71 (3.8%) stddev-sans-first:2.77 16:40:36 INFO - PID 4180 | Values: 70.0 71.0 75.0 71.0 73.0 69.0 72.0 71.0 78.0 70.0 16:40:36 INFO - PID 4180 | -------- Summary: end -------- 16:40:36 INFO - PID 4180 | 16:40:37 INFO - TEST-INFO | 4180: exit 0 16:40:37 INFO - TEST-OK | kraken | took 91339ms 16:40:37 INFO - SUITE-END | took 1234s 16:40:37 INFO - Completed test suite (00:20:35) 16:40:37 INFO - javascript benchmark 16:40:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7737.854029073901, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3062.6018617579716, 3101.0, 3107.9067627971167, 3109.5802066720985, 3126.7967582107162, 5837.0, 5862.73617687204, 5917.88164236715, 6027.849303767408, 6031.879362412755, 5881.67650779207, 5967.612105213158, 5970.194023806785, 5971.731272092756, 6061.272647282332, 5381.81163659272, 5494.532964698005, 5524.8342549723375, 5526.47498487643, 5543.501084902358, 5588.832335029955, 5598.4961353478175, 5616.85957851055, 5625.6905870177125, 5631.521320687726, 5421.647592906448, 5449.782008719647, 5504.889902201953, 5515.4760297771645, 5524.254225679522, 5489.752961116759, 5509.173623956399, 5547.639403438763, 5592.412796656374, 5603.991281569316, 5492.340919089735, 5506.311711036121, 5521.420250873641, 5526.253955715967, 5533.529649979716, 5787.797427090031, 5864.501517371029, 5956.315023772278, 5974.790882319141, 5981.282246130449, 6395.968020159869, 6513.739450421977, 6514.315996820313, 6528.21661400635, 6545.705443255018, 6547.377999090078, 6551.246606640202, 6557.114789503451, 6566.835829104263, 6567.277599464055, 5863.589548731547, 6052.303985041688, 6067.969660151715, 6077.665728384893, 6083.087536869505, 6576.4410025147445, 6602.8349291268105, 6690.632015239208, 6694.966525167343, 6706.530542861953, 6031.517478601701, 6083.209182806296, 6116.731440059295, 6376.458001069868, 6381.425671689477, 6461.386168314003, 6461.741530338828, 6463.256725476536, 6465.4827613790785, 6488.708008139645, 6296.811095667137, 6381.425671689571, 6448.935510644834, 6464.159659244268, 6478.255000674889, 6338.271098823694, 6356.4279214870885, 6379.138816259839, 6402.647854368054, 6438.163038804925, 5302.867428314245, 5324.866878328073, 5328.040952628564, 5331.040412725747, 5331.626786125012, 4506.301523263899, 4511.751853648081, 4523.231050721385, 4526.162659907927, 4542.364069030338, 5395.568354531628, 5454.863628409322, 5467.043267428184, 5535.667859928417, 5550.944490555124, 6549.541532092708, 6563.1796025496815, 6564.80305590833, 6566.0, 6568.540202185896, 5578.776848926079, 5579.6652200868075, 5585.0, 5592.328920529481, 5619.129034999582, 5584.21820945068, 5652.349979752299, 5708.086706127, 5775.5090817281, 5805.709714514257, 6268.341824108403, 6274.749010039639, 6295.748170073146, 6297.937020629826, 6306.621602703853, 6460.741570337133, 6490.377405648588, 6499.5125365598715, 6532.575382600306, 6535.901961470487, 6144.600600960924, 6292.748290068346, 6296.181496405438, 6306.779262725782, 6319.115323854756, 6234.937650623617, 6280.7487700491465, 6313.494920406265, 6338.968305158444, 6339.778107766206, 6560.803175904731, 6577.80266592003, 6582.539222254396, 6586.077949087227, 6597.637129957899, 5918.17145599625, 6092.055731361646, 6121.173641558333, 6200.968995155175, 6318.652474113784, 6329.746810127727, 6330.335314792064, 6331.2085989251345, 6347.460465860454, 6351.777687780906, 6099.298580663103, 6117.357677443804, 6151.446369826737, 6167.136600875791, 6269.31037585856, 6284.4344009039405, 6301.369863013845, 6344.9048264277, 6352.777652782131, 6389.9680501597195, 6175.505959523317, 6175.536834737502, 6180.351063138485, 6189.288231853215, 6191.876162476815], "value": 5890.477330913563, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.2994719989612, 788.298414411174, 800.8198155415032, 1164.1036401970482, 1176.041526156182, 34489.65510344896, 36181.0, 36250.456243156375, 36292.0, 36294.27411451773, 38402.0, 38580.614193858055, 38815.41776873349, 38833.417498737545, 38923.416148757795, 7155.642217889111, 7281.9271807281775, 7375.299346562095, 7400.296971787671, 7411.036565246511, 7369.115706115247, 7405.296496832819, 7450.962745186266, 7453.180150183475, 7456.105267367923, 7346.889796653055, 7426.405887529012, 7458.4033277337685, 7475.401967842587, 7483.9896613957235, 7370.705171793122, 7405.518641288299, 7406.9629651851665, 7439.665215065281, 7451.403887688972, 7271.454640901953, 7272.272772722738, 7283.308085731847, 7310.049693539859, 7340.96329518349, 34813.30373392518, 35087.4736878947, 35168.648313516795, 35216.471752923724, 35244.118897027525, 3356.9664303357144, 3395.6774106459848, 3397.184675677844, 3397.3545026445145, 3404.897853064412, 27403.72596274032, 27522.862385687942, 27588.172354829185, 27590.0, 27634.032808851796, 3360.1095709636966, 3366.309906469168, 3403.9659603403898, 3411.385950528904, 3412.436947903593, 129654.0, 134643.0, 134668.0, 163175.18412407863, 163931.9999999988, 38136.0, 38286.0, 38357.424638630444, 38373.424398633484, 38408.42387364192, 39999.60000400017, 40128.39807402891, 40193.79903100524, 40317.193656126714, 40390.39414408786, 14477.131372117707, 14519.78220326696, 14571.271436428136, 14574.052686575338, 14668.926655366655, 12032.03743700502, 12115.0, 12124.333161676192, 12174.634760957186, 12188.20776649515, 13666.726665466835, 13673.042886998013, 13708.012338210903, 13734.65663358404, 13833.308334583231, 5768.567357448124, 5837.956715149664, 5863.560232982543, 5893.764249430061, 5909.261342332208, 1007.4912169354576, 1011.6610935336597, 1017.765913839821, 1025.5692609104194, 1032.3444612670858, 21499.42006959175, 22014.779852201595, 22215.44461388478, 22628.321150365515, 22752.431189220402, 1082.4749996251812, 1085.7068591480256, 1113.7939481196004, 1118.3848883114254, 1126.1553834624033, 11847.407629618485, 11934.462949167308, 12123.515059397701, 12211.206271592318, 12817.35913204336, 196945.0, 197081.0, 197650.0, 198266.0, 199354.0, 48968.02063958701, 49399.753001235484, 49580.50419495831, 49610.75194624004, 49632.75183624059, 1410.8448070712213, 1464.7729601911722, 1477.7709455034487, 1481.9259037047889, 1482.05148704829, 20630.828983499254, 21061.368158955254, 22228.777712222673, 22277.8087205601, 22556.774432255468, 33882.83058584691, 35122.297554048266, 35405.0, 35541.466877997365, 35723.82138089293, 169541.0, 169719.0, 170165.04422345158, 171419.14290428467, 172738.0, 27437.0, 27777.861110694317, 29264.975725849494, 30540.694593054675, 31749.841250793597, 36121.63878361183, 36230.637693622724, 36760.448593271656, 36979.63020369762, 37311.44032839564, 27482.17553473319, 27515.86242068777, 27980.0, 28539.714602853706, 28764.85617571899, 26890.596641050008, 27748.722512774613, 28039.0, 28237.15288541347, 28485.43029139447, 30212.09363719092, 30841.537376939814, 30851.074467766004, 30903.69096309008, 31092.844535777178, 26438.867805660848, 26487.518252903898, 27260.591091134047, 27432.314192145357, 28154.2961425966, 21770.564588708454, 22436.551268974854, 22469.325920222418, 22585.30610204274, 22767.544649106592], "value": 15603.80426851835, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [467.376052969286, 479.6522521172151, 480.65873230006696, 488.9535494128058, 503.12958581653737, 14732.0, 15404.460843870467, 20522.692159617618, 21226.257081002168, 21237.469063273405, 21488.570228595418, 22161.66757498639, 22305.330840074785, 22306.553868922612, 22399.55200895981, 5976.611520251192, 6127.540434467411, 6173.660448675321, 6174.135621013062, 6185.845353866144, 5945.672987985659, 6018.3981601839905, 6056.242969628796, 6066.363031881655, 6067.393260673919, 5554.1113421852515, 5805.303363596375, 5889.823305300848, 5987.970060149693, 5997.910031349533, 5838.357780644125, 5920.97039514804, 5924.644521328734, 5925.081612350093, 5931.051031834929, 5422.6475279106735, 5426.701531415771, 5432.809851655213, 5439.93921185369, 5444.5916556258435, 23803.0, 23807.88096059526, 23831.165909193096, 23879.88060059706, 24042.0, 1911.1972971352066, 1954.5797653504565, 1962.3622322745023, 1964.9508762280914, 1973.1712680674152, 15941.202939853078, 17116.572085697833, 17127.57181070483, 17143.571410714707, 17161.14194290293, 2156.8813715245656, 2159.902804373807, 2214.7895949884737, 2226.265332440307, 2227.4208705736464, 105006.0, 105889.0, 106265.46867265615, 106495.0, 106700.0, 11851.288922664668, 12626.30555319448, 12752.298623575607, 14256.215908124945, 14257.714845703027, 19100.33148839812, 19113.139908704143, 19117.522061948563, 19325.323613673452, 19339.12973916177, 8781.165789250012, 8886.911130888737, 8931.106889311146, 8975.147361000694, 8985.955070224607, 8227.794305142299, 8330.291925186428, 8349.582520873932, 8357.206065423776, 8419.326453883674, 7892.9210707893335, 8047.879281810778, 8052.235037671529, 8079.515229086273, 8195.549244791475, 2177.825773938081, 2181.2801775414077, 2219.55608878225, 2287.9199228026937, 2308.607536718762, 940.3558562384652, 963.1524258652341, 973.8661204876285, 997.2670087485692, 998.2912132386087, 18354.357597484024, 18684.53288667767, 19053.333133340268, 20577.794222057586, 22683.430249866247, 968.8788901387327, 1001.8296889528798, 1017.760826205841, 1027.635189507729, 1045.9320144190604, 10002.449865257335, 10336.741581460374, 10533.210009249337, 10566.260361774755, 10653.520591573399, 409887.0, 412903.0, 413277.0, 415516.0, 420971.0, 94103.0, 95274.0, 96143.51928240314, 96583.0, 96694.51652741691, 1223.590097317391, 1242.1739543203848, 1245.875412458765, 1247.8065899785547, 1256.5225214418463, 15841.128737919526, 18594.535136621693, 20437.182512699324, 20468.590628187056, 20849.791502084787, 48821.53535393944, 49612.503874960785, 50003.0, 50819.0, 50870.745646271534, 57983.0, 58245.417545824, 58591.121133183886, 58617.12074318974, 58734.70632646809, 11220.831687524857, 11441.942790285995, 11553.13351498624, 11557.88442115568, 11563.595274165364, 16747.665046699243, 17871.553211169823, 17942.19260133271, 18156.45530634083, 18322.450326490227, 14682.486112985995, 14751.188684622448, 14767.92616036956, 14772.113673179643, 14786.704265914837, 13694.65763355924, 13851.653708657364, 14030.438782448997, 14059.507917222849, 14233.928830355782, 14726.63183420423, 14784.408623655363, 14797.630059248175, 15255.313510891814, 15554.688906221585, 11293.887061129612, 11332.150088743541, 11387.54449822031, 11437.771244575228, 11486.597969071043, 14154.50459233963, 14217.786733198804, 14249.0, 14250.572482825532, 14269.286535672967], "value": 10457.705908680307, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1290.348374071094, 1315.8617795606797, 1351.2770667692773, 1354.3702178487008, 1377.5522955039614, 11516.309021458708, 11838.171328007022, 12178.269303841764, 12194.451249693762, 12282.263064216153, 11982.340971246578, 12122.515099396014, 12156.27062376258, 12177.269363838175, 12210.145289829716, 2480.516299321633, 2505.361132911105, 2506.0226511660467, 2531.493701259746, 2539.771420572148, 2434.3427274635837, 2503.7371076036934, 2504.6743923289946, 2508.598624220125, 2511.3470497670646, 2432.19737486629, 2450.9387265318333, 2463.938401539958, 2466.703995520531, 2468.8395254308502, 2311.9884400577976, 2360.84654497458, 2376.584097782881, 2383.547126046063, 2388.6536452214505, 2295.4490922178725, 2358.4929240213437, 2365.988170059156, 2450.3016640257442, 2457.410221546834, 11885.584004559885, 11994.580189693406, 12001.51993920242, 12001.519939202508, 12003.759924801456, 6558.475321974231, 6826.522143449961, 6831.0, 6839.0425340452375, 6844.076049733322, 3917.392804115338, 4125.793710314502, 4192.559781222989, 4228.238916994939, 4233.618974292298, 1404.3329418526118, 1405.7329107469548, 1408.1058527834796, 1438.2161721861505, 1454.7454195515847, 16684.165791710366, 17128.400505982354, 18120.0, 18242.817571824377, 18245.54386140344, 5699.088145896637, 5759.107338362561, 5880.7944371403755, 5922.437368449991, 5944.138099975479, 13688.384022719001, 13704.3833027514, 13809.0, 13847.376868040963, 13852.722945541032, 6476.417122459001, 6724.125863637696, 6733.494987875929, 6734.259231484532, 6739.764108256286, 6198.938010619926, 6233.906491402633, 6269.435750782452, 6277.027060805583, 6315.778947736807, 4491.214037543482, 4602.424696912886, 4605.102005109038, 4642.187617166982, 4658.324542941255, 1353.1204716934071, 1360.3266383140408, 1368.8836448901955, 1378.7725025370903, 1387.3826147364325, 834.8956380452444, 849.541247726221, 853.3898262742046, 872.6029656506274, 889.7731078574922, 6601.174853143357, 6601.900971485432, 6671.499637527205, 6789.694463749143, 6888.207856096513, 669.0766741896249, 695.6035060015743, 706.3819158236543, 712.6294326949957, 714.3999040805749, 4041.454403655469, 4106.0, 4157.064660451435, 4219.852305169305, 4233.978830105892, 15240.314185861664, 15804.841951580567, 15809.525714228592, 15814.68370632581, 15868.841311586737, 15513.689726205639, 15692.68614627724, 15765.08647505288, 15934.60163495922, 16327.265273062503, 9391.530423478798, 9717.076877696607, 9989.150922171697, 9992.450415227233, 9994.950025249973, 6761.290064543152, 7099.396551293198, 7459.738909138154, 7516.210797866145, 7632.5038872473115, 14339.0, 14371.496997605034, 14456.2049087297, 14580.125192488485, 14627.488037918622, 14484.565463036126, 14597.343119559433, 14638.414463421344, 14664.340104695528, 14790.11259324444, 10095.192384609067, 10139.645112421325, 10253.641122560675, 10257.128144107535, 10339.63811266602, 11272.154588406067, 11453.713657158638, 11453.828192576952, 11457.59898403552, 11466.31202127875, 9267.258619310303, 9498.335116541775, 9526.52367381642, 9728.027197280499, 9807.85288220663, 9142.954285228798, 9151.450912945245, 9165.633374665205, 9343.112404321579, 9571.0, 8385.161483851565, 8460.323174145931, 8519.403641745019, 8563.186497282748, 8573.314134869071, 6088.178095956989, 6183.876322473436, 6371.87256254863, 6483.870322593616, 6612.0, 6307.05394190875, 6392.52056095804, 6560.40956313934, 6681.899771503334, 6782.423494003065], "value": 5568.789203876228, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [441.94033805436266, 460.82488654311356, 461.95842374186316, 473.64949937046595, 475.70743992444636, 6104.816855494331, 6338.9049164262515, 6356.968215158918, 6367.904481432776, 6376.150916234286, 5960.79137230197, 6128.816135515931, 6132.632042077478, 6135.907961380572, 6160.414760597747, 4787.13831510328, 4922.80308787648, 4932.284818701304, 4936.703797772145, 4958.652894297401, 4979.551840334369, 4990.775415106311, 4991.575716064139, 4997.875053123683, 5003.74981250936, 4914.901701965977, 4931.605471562267, 4931.605471562267, 4932.865440948584, 4943.505649435064, 4907.484714105021, 4918.852434426973, 4930.80276788928, 4947.975260123712, 4952.504749525055, 4367.8114976067645, 4369.497507786614, 4382.342648602703, 4387.934180987288, 4397.604215620578, 6116.357782432825, 6155.907661385083, 6163.352847950945, 6164.445199932027, 6174.876502469971, 5642.7742890284335, 5658.886822263573, 5660.66036037835, 5665.051695719478, 5707.571932105067, 6560.606363618198, 6578.6381749003785, 6583.967080164616, 6595.340465953414, 6610.0745895574655, 4793.544613261734, 4794.736289504076, 4794.856154315376, 4797.9520204797855, 4799.880002999953, 6529.510286728514, 6898.793036208922, 6915.827104322432, 6939.965300173517, 6983.406410455117, 4775.164346239464, 4849.75751212445, 4862.635302352338, 4862.805487780449, 4865.343178670834, 4885.413750349981, 4905.264210368473, 4911.287863259808, 4917.164082106051, 4928.408590969107, 5394.217838413408, 5589.245451864028, 5595.132754423071, 5601.719914004283, 5610.541259272619, 6516.739330426824, 6556.409923106943, 6573.474122070223, 6610.338966103447, 6615.702293396808, 1695.3472912928612, 1715.7254839225664, 1722.190570431895, 1725.3098760495902, 1729.2564197394988, 1108.257467496779, 1161.6456980620992, 1172.783035138502, 1187.0978056676815, 1191.2614179208947, 5727.914081288784, 5755.647422855625, 5780.624259423124, 5783.132530120515, 5830.766769329264, 6803.795886123424, 6820.147481564804, 6827.419669328064, 6845.247022827485, 6860.5197636164985, 5722.484976352148, 5735.627184233012, 5751.0, 5751.338596061423, 5782.0, 3607.8196090195383, 3625.492431059654, 3629.6007439181667, 3634.47300141478, 3635.600083990759, 6549.476041916635, 6594.637294948728, 6620.139381880324, 6636.900446493307, 6638.838203314401, 6856.314368563104, 6876.553024053421, 6910.170779506391, 6953.6440394122665, 6954.478414118961, 6374.904376434357, 6488.480921526267, 6553.0, 6612.5040621952585, 6620.172478440195, 6750.2237242715755, 6758.42553382968, 6796.320367963164, 6801.421879140328, 6833.145856767904, 6715.697793599202, 6775.661216939035, 6779.694913728796, 6783.626900520321, 6786.423154031962, 6156.5998210116195, 6473.77341793035, 6544.738210471718, 6556.147700798866, 6607.9669601651685, 5266.683998960075, 5327.8299411849885, 5333.653312534673, 5334.1732031535175, 5351.1973204019705, 6481.222253329631, 6750.831229219309, 6779.15260592426, 6782.457403407814, 6812.671529051788, 6545.443637290884, 6575.0, 6577.868442631217, 6578.506612004023, 6600.108985287116, 6556.0, 6563.540552161494, 6570.145881035626, 6621.106150669598, 6664.566803157779, 6437.034444833125, 6451.677416129269, 6488.805335839932, 6550.508711846535, 6556.492006838549, 6635.0, 6640.169978752656, 6653.63405012729, 6662.500312476487, 6662.83342916431, 6402.167718196604, 6444.581102228341, 6445.16212892321, 6446.226452825691, 6472.385123413268], "value": 5039.005266626156, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [796.4703472190994, 810.266708628691, 811.5455345006793, 825.1088824070004, 825.7605294464602, 15167.848321516782, 15604.999999999985, 15617.0, 17465.388711395102, 19002.334918277862, 17403.651926961455, 18519.351822686207, 18876.339328123486, 18899.811001889975, 18900.0, 967.9467629280387, 992.5731935267831, 993.3940296419179, 994.9900500995006, 997.1175509673918, 944.3955868244329, 981.5337714585586, 997.0478193325393, 1001.9749506262328, 1004.0712341084504, 1063.059192614534, 1063.0857462582173, 1063.415121683075, 1064.7391389109641, 1064.9893501065008, 1050.333038520541, 1054.4147997861185, 1055.208593554834, 1055.8996895294936, 1056.2922841696081, 764.7820371194183, 766.1457474915485, 772.1082150116624, 774.1329710724025, 774.4540099230029, 13475.528356507573, 15892.0, 16038.75941860873, 16050.678986420324, 16087.678246435124, 17520.737188942177, 17523.47429577102, 17780.555486112822, 18038.0, 18042.729359059624, 14321.0, 14645.780313295309, 14646.267686615627, 14648.560543183721, 14672.926635366755, 3392.1858753899132, 3395.5925288965236, 3403.7957722536726, 3404.591449026108, 3421.0934102462866, 74348.62825685837, 76272.0, 77084.0, 77576.61211693905, 78442.6077869607, 13618.387172577257, 14153.433862645585, 14180.716385672229, 14260.786088208684, 14313.21277329736, 22469.325920222418, 22745.658815117786, 22954.081836726677, 22973.081076756742, 22980.310590682308, 7991.920080799234, 8176.959115204386, 8271.090180080186, 8363.080061193265, 8371.204735550113, 3976.423418604344, 4060.1879624075304, 4060.715749897538, 4063.553009168989, 4079.7756123413496, 4373.540778218305, 4380.3210502372185, 4467.329900514948, 4499.617532509773, 4535.0249696314795, 851.1360968616859, 853.4964371021127, 866.2766589897507, 866.3026263857529, 869.7347309070668, 682.9453643708491, 685.9108315918899, 704.2183176673888, 705.4074577355046, 726.3644311227675, 10562.0, 11055.170862185369, 11209.887901121048, 11582.47878845454, 11826.526938922347, 681.5672048249298, 686.6703982088626, 701.2846896165883, 710.7761055267574, 712.2877122877123, 5170.087067784943, 5305.973470132624, 5434.266374039533, 5446.291982042309, 5533.114701647797, 90729.0, 91425.54287228521, 92758.0, 93286.53356733173, 94548.52725736327, 70555.6472217646, 71846.281537185, 72484.0, 72684.2731572688, 72820.0, 63384.36615633877, 63481.36518634847, 63938.99999999907, 64274.0, 65075.67462162659, 11537.769244615229, 12149.271043737404, 12162.513499459923, 12298.81551776742, 12429.12996090265, 28249.0, 28483.145505634864, 28490.43019139564, 28650.856745716137, 29009.854950725112, 35728.64271357357, 36075.0, 36344.0, 36815.81592092022, 37237.62762372341, 15454.072755634697, 15658.21708914527, 15829.366825326859, 15862.286197120926, 16046.518604441886, 17701.29194832244, 17917.0, 18132.18405171744, 18465.076746162908, 18571.44285671432, 16332.59168520749, 16335.428260010842, 16407.343706251617, 16557.58606034859, 16711.91644041772, 16026.358945642043, 16429.753553696464, 16505.0, 16577.088260145807, 16745.24646390891, 14833.851661483248, 15122.0, 15176.0, 15188.164650943861, 15473.458428954933, 11267.887321126684, 11306.378149201873, 11609.361485118061, 11679.474423651127, 12194.268343899394, 12692.0, 12987.0, 13634.250116243702, 13719.657008574866, 13927.164370137823], "value": 7957.47200976949, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1562.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 109.0, 102.0, 111.0, 110.0, 111.0, 112.0, 101.0, 111.0, 112.0], "value": 108.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 124.0, 153.0, 184.0, 120.0, 150.0, 153.0, 125.0, 164.0, 122.0], "value": 144.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 165.0, 161.0, 166.0, 164.0, 168.0, 169.0, 167.0, 162.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 73.0, 186.0, 74.0, 77.0, 77.0, 77.0, 168.0, 74.0], "value": 95.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 131.0, 84.0, 82.0, 84.0, 132.0, 83.0, 82.0, 132.0], "value": 97.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 113.0, 114.0, 114.0, 113.0, 113.0, 114.0, 114.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 150.0, 149.0, 151.0, 150.0, 150.0, 151.0, 149.0, 151.0], "value": 150.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 58.0, 54.0, 56.0, 55.0, 56.0, 54.0, 55.0, 58.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 56.0, 56.0, 55.0, 56.0, 56.0, 55.0, 55.0], "value": 55.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 82.0, 82.0, 85.0, 82.0, 98.0, 103.0, 84.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 130.0, 132.0, 132.0, 133.0, 130.0, 130.0, 146.0, 139.0, 134.0], "value": 135.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 190.0, 201.0, 186.0, 197.0, 183.0, 178.0, 187.0, 192.0, 179.0], "value": 188.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 75.0, 71.0, 73.0, 69.0, 72.0, 71.0, 78.0, 70.0], "value": 72.0, "unit": "score"}]}]} 16:40:37 INFO - Return code: 0 16:40:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:40:38 INFO - # TBPL SUCCESS # 16:40:38 INFO - Running post-action listener: _resource_record_post_action 16:40:38 INFO - [mozharness: 2017-06-09 23:40:38.017717Z] Finished run-tests step (success) 16:40:38 INFO - Running post-run listener: _resource_record_post_run 16:40:38 INFO - Total resource usage - Wall time: 1253s; CPU: 13.0%; Read bytes: 8798208; Write bytes: 431575040; Read time: 3284; Write time: 308164 16:40:38 INFO - TinderboxPrint: CPU usage
12.6% 16:40:38 INFO - TinderboxPrint: I/O read bytes / time
8,798,208 / 3,284 16:40:38 INFO - TinderboxPrint: I/O write bytes / time
431,575,040 / 308,164 16:40:38 INFO - TinderboxPrint: CPU idle
8,737.5 (87.4%) 16:40:38 INFO - TinderboxPrint: CPU user
1,209.7 (12.1%) 16:40:38 INFO - TinderboxPrint: Swap in / out
0 / 0 16:40:38 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 8192; Write bytes: 134524928; Read time: 128; Write time: 84576 16:40:38 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:40:38 INFO - run-tests - Wall time: 1236s; CPU: 13.0%; Read bytes: 6758400; Write bytes: 202981376; Read time: 2860; Write time: 123820 16:40:38 INFO - Running post-run listener: _upload_blobber_files 16:40:38 INFO - Blob upload gear active. 16:40:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:40:38 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 16:40:38 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'] 16:40:38 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 16:40:39 INFO - (blobuploader) - INFO - Open directory for files ... 16:40:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:40:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:40:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:40:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:40:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:40:40 INFO - (blobuploader) - INFO - Done attempting. 16:40:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:40:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:40:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:40:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:40:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:40:46 INFO - (blobuploader) - INFO - Done attempting. 16:40:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:40:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:40:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:40:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:40:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:40:47 INFO - (blobuploader) - INFO - Done attempting. 16:40:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:40:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:40:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:40:49 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:40:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:40:49 INFO - (blobuploader) - INFO - Done attempting. 16:40:49 INFO - (blobuploader) - INFO - Iteration through files over. 16:40:49 INFO - Return code: 0 16:40:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:40:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:40:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/15a25c147feece0fd422eb504b2f274877c3af46331f549ed2d0ab3620acd5c3b4911423f2b62686b4b259b7a4e19ab795a64e4858ebfc4dca2e9b1bc59ebe5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4cff8738a6aa5801b1cc4669bca37f06ee5c765b9381c9f64c9c539afb36d840787f9aa0eecc089bec5bfe9f2ccdcbeb7e2157b5ea7e8123a4d3f1b30c69f4d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2dba309d1f6b43d6d89c6c9074a123d52e94021ef10223a6e104ea13b806e1f47128d4d767895a98959e468eabead6bc842bada4822d2a339d5b6db8913a2435", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8b31217a0b984043418238fc61cd0c8b05ded608c1b8f362c07ebe7c08e29a0bdc5fd1cff3660915e37577fac3056f39c9b3ab8c7f23397ddb9c065be35921c5"} 16:40:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:40:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:40:49 INFO - Contents: 16:40:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/15a25c147feece0fd422eb504b2f274877c3af46331f549ed2d0ab3620acd5c3b4911423f2b62686b4b259b7a4e19ab795a64e4858ebfc4dca2e9b1bc59ebe5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4cff8738a6aa5801b1cc4669bca37f06ee5c765b9381c9f64c9c539afb36d840787f9aa0eecc089bec5bfe9f2ccdcbeb7e2157b5ea7e8123a4d3f1b30c69f4d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2dba309d1f6b43d6d89c6c9074a123d52e94021ef10223a6e104ea13b806e1f47128d4d767895a98959e468eabead6bc842bada4822d2a339d5b6db8913a2435", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8b31217a0b984043418238fc61cd0c8b05ded608c1b8f362c07ebe7c08e29a0bdc5fd1cff3660915e37577fac3056f39c9b3ab8c7f23397ddb9c065be35921c5"} 16:40:49 INFO - Running post-run listener: copy_logs_to_upload_dir 16:40:49 INFO - Copying logs to upload dir... 16:40:49 INFO - mkdir: /builds/slave/test/build/upload/logs 16:40:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1318.018972 ========= master_lag: 0.26 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2017-06-09 16:40:49.232186) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-09 16:40:49.241814) ========= 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=db0483c52d987ecb441a263b000001ad-1497038885.99686-1458522901 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/15a25c147feece0fd422eb504b2f274877c3af46331f549ed2d0ab3620acd5c3b4911423f2b62686b4b259b7a4e19ab795a64e4858ebfc4dca2e9b1bc59ebe5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4cff8738a6aa5801b1cc4669bca37f06ee5c765b9381c9f64c9c539afb36d840787f9aa0eecc089bec5bfe9f2ccdcbeb7e2157b5ea7e8123a4d3f1b30c69f4d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2dba309d1f6b43d6d89c6c9074a123d52e94021ef10223a6e104ea13b806e1f47128d4d767895a98959e468eabead6bc842bada4822d2a339d5b6db8913a2435", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8b31217a0b984043418238fc61cd0c8b05ded608c1b8f362c07ebe7c08e29a0bdc5fd1cff3660915e37577fac3056f39c9b3ab8c7f23397ddb9c065be35921c5"} build_url:https://queue.taskcluster.net/v1/task/WOD1aXL-Re-nV13fq7Zfhg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011167 build_url: 'https://queue.taskcluster.net/v1/task/WOD1aXL-Re-nV13fq7Zfhg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/15a25c147feece0fd422eb504b2f274877c3af46331f549ed2d0ab3620acd5c3b4911423f2b62686b4b259b7a4e19ab795a64e4858ebfc4dca2e9b1bc59ebe5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4cff8738a6aa5801b1cc4669bca37f06ee5c765b9381c9f64c9c539afb36d840787f9aa0eecc089bec5bfe9f2ccdcbeb7e2157b5ea7e8123a4d3f1b30c69f4d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2dba309d1f6b43d6d89c6c9074a123d52e94021ef10223a6e104ea13b806e1f47128d4d767895a98959e468eabead6bc842bada4822d2a339d5b6db8913a2435", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8b31217a0b984043418238fc61cd0c8b05ded608c1b8f362c07ebe7c08e29a0bdc5fd1cff3660915e37577fac3056f39c9b3ab8c7f23397ddb9c065be35921c5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-09 16:40:49.267710) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-09 16:40:49.268028) ========= 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=db0483c52d987ecb441a263b000001ad-1497038885.99686-1458522901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004366 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-09 16:40:49.351851) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-09 16:40:49.352260) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-09 16:40:49.355864) ========= ========= Total master_lag: 0.42 =========