builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-086 starttime: 1500552569.76 results: success (0) revision: 68046a58f82913eb7804e4796ec981f6f8ea490e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-20 05:09:29.763462) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-20 05:09:29.763943) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-20 05:09:29.764242) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-20 05:09:29.819649) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-20 05:09:29.819957) ========= 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=438111f3d31ce799eff2119d000001bc-1500545008.302335-83748825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-20 05:09:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 111M=0s 2017-07-20 05:09:30 (111 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.133097 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-20 05:09:30.016872) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-20 05:09:30.017211) ========= 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=438111f3d31ce799eff2119d000001bc-1500545008.302335-83748825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.072748 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-20 05:09:30.101910) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-20 05:09:30.102291) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 68046a58f82913eb7804e4796ec981f6f8ea490e --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 68046a58f82913eb7804e4796ec981f6f8ea490e --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=438111f3d31ce799eff2119d000001bc-1500545008.302335-83748825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-20 05:09:30,230 truncating revision to first 12 chars 2017-07-20 05:09:30,231 Setting DEBUG logging. 2017-07-20 05:09:30,231 attempt 1/10 2017-07-20 05:09:30,231 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/68046a58f829?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-20 05:09:30,698 unpacking tar archive at: mozilla-central-68046a58f829/testing/mozharness/ program finished with exit code 0 elapsedTime=0.786874 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-20 05:09:30.902293) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-20 05:09:30.902713) ========= script_repo_revision: 68046a58f82913eb7804e4796ec981f6f8ea490e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-20 05:09:30.903175) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-20 05:09:30.903460) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-20 05:09:30.916187) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-07-20 05:09:30.916551) ========= /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=438111f3d31ce799eff2119d000001bc-1500545008.302335-83748825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:09:31 INFO - MultiFileLogger online at 20170720 05:09:31 in /builds/slave/test 05:09:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 05:09:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:09:31 INFO - {'append_to_log': False, 05:09:31 INFO - 'base_work_dir': '/builds/slave/test', 05:09:31 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:09:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:09:31 INFO - 'branch': 'Firefox-Non-PGO', 05:09:31 INFO - 'buildbot_json_path': 'buildprops.json', 05:09:31 INFO - 'code_coverage': False, 05:09:31 INFO - 'config_files': ('talos/linux_config.py',), 05:09:31 INFO - 'default_actions': ('clobber', 05:09:31 INFO - 'read-buildbot-config', 05:09:31 INFO - 'download-and-extract', 05:09:31 INFO - 'populate-webroot', 05:09:31 INFO - 'create-virtualenv', 05:09:31 INFO - 'install', 05:09:31 INFO - 'setup-mitmproxy', 05:09:31 INFO - 'run-tests'), 05:09:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:09:31 INFO - 'disable_ccov_upload': False, 05:09:31 INFO - 'download_minidump_stackwalk': True, 05:09:31 INFO - 'download_symbols': 'ondemand', 05:09:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:09:31 INFO - 'tooltool.py': '/tools/tooltool.py', 05:09:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:09:31 INFO - '/tools/misc-python/virtualenv.py')}, 05:09:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:09:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:09:31 INFO - 'gecko_profile': False, 05:09:31 INFO - 'gecko_profile_interval': 0, 05:09:31 INFO - 'installer_path': 'installer.exe', 05:09:31 INFO - 'log_level': 'info', 05:09:31 INFO - 'log_name': 'talos', 05:09:31 INFO - 'log_to_console': True, 05:09:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:09:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:09:31 INFO - 'opt_config_files': (), 05:09:31 INFO - 'pip_index': False, 05:09:31 INFO - 'suite': 'dromaeojs-e10s', 05:09:31 INFO - 'system_bits': '32', 05:09:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:09:31 INFO - 'title': 'talos-linux64-ix-086', 05:09:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:09:31 INFO - 'use_talos_json': True, 05:09:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:09:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:09:31 INFO - 'work_dir': 'build'} 05:09:31 INFO - [mozharness: 2017-07-20 12:09:31.267140Z] Running clobber step. 05:09:31 INFO - Running pre-action listener: _resource_record_pre_action 05:09:31 INFO - Running main action method: clobber 05:09:31 INFO - rmtree: /builds/slave/test/build 05:09:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:09:33 INFO - Running post-action listener: _resource_record_post_action 05:09:33 INFO - [mozharness: 2017-07-20 12:09:33.256679Z] Finished clobber step (success) 05:09:33 INFO - [mozharness: 2017-07-20 12:09:33.256796Z] Running read-buildbot-config step. 05:09:33 INFO - Running pre-action listener: _resource_record_pre_action 05:09:33 INFO - Running main action method: read_buildbot_config 05:09:33 INFO - Using buildbot properties: 05:09:33 INFO - { 05:09:33 INFO - "project": "", 05:09:33 INFO - "product": "firefox", 05:09:33 INFO - "who": "archaeopteryx@coole-files.de", 05:09:33 INFO - "installer_path": "public/build/target.tar.bz2", 05:09:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:09:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:09:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 05:09:33 INFO - "stage_platform": "linux64", 05:09:33 INFO - "basedir": "/builds/slave/test", 05:09:33 INFO - "buildnumber": 1022, 05:09:33 INFO - "platform": "ubuntu64_hw", 05:09:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:09:33 INFO - "slavebuilddir": "test", 05:09:33 INFO - "taskId": "dNX628w3TxquFx2SuQfi6g", 05:09:33 INFO - "branch": "mozilla-central", 05:09:33 INFO - "script_repo_revision": "production", 05:09:33 INFO - "revision": "68046a58f82913eb7804e4796ec981f6f8ea490e", 05:09:33 INFO - "slavename": "talos-linux64-ix-086", 05:09:33 INFO - "repo_path": "mozilla-central" 05:09:33 INFO - } 05:09:33 INFO - Finding installer, test and symbols from parent task. 05:09:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dNX628w3TxquFx2SuQfi6g'}, attempt #1 05:09:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dNX628w3TxquFx2SuQfi6g'}, attempt #1 05:09:34 INFO - Task dependencies: YDBNoQM-Ta2UROCREiJdZw 05:09:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YDBNoQM-Ta2UROCREiJdZw'}, attempt #1 05:09:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/YDBNoQM-Ta2UROCREiJdZw/artifacts/public/build/target.tar.bz2 05:09:34 INFO - Set test_url: https://queue.taskcluster.net/v1/task/YDBNoQM-Ta2UROCREiJdZw/artifacts/public/build/test_packages.json 05:09:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/YDBNoQM-Ta2UROCREiJdZw/artifacts/public/build/target.crashreporter-symbols.zip 05:09:34 INFO - Running post-action listener: _resource_record_post_action 05:09:34 INFO - [mozharness: 2017-07-20 12:09:34.620988Z] Finished read-buildbot-config step (success) 05:09:34 INFO - [mozharness: 2017-07-20 12:09:34.621209Z] Running download-and-extract step. 05:09:34 INFO - Running pre-action listener: _resource_record_pre_action 05:09:34 INFO - Running main action method: download_and_extract 05:09:34 INFO - mkdir: /builds/slave/test/build/tests 05:09: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')]} 05:09:34 INFO - trying https://queue.taskcluster.net/v1/task/YDBNoQM-Ta2UROCREiJdZw/artifacts/public/build/target.test_packages.json 05:09:34 INFO - Downloading https://queue.taskcluster.net/v1/task/YDBNoQM-Ta2UROCREiJdZw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:09:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YDBNoQM-Ta2UROCREiJdZw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:09:35 INFO - Downloaded 989 bytes. 05:09:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:09:35 INFO - Using the following test package requirements: 05:09:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:09:35 INFO - u'common': [u'target.common.tests.zip'], 05:09:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:09:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:09:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:09:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:09:35 INFO - u'mozbase': [u'target.common.tests.zip'], 05:09:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:09:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:09:35 INFO - u'web-platform': [u'target.common.tests.zip', 05:09:35 INFO - u'target.web-platform.tests.tar.gz'], 05:09:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:09:35 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:09:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YDBNoQM-Ta2UROCREiJdZw/artifacts/public/build/target.common.tests.zip 05:09:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YDBNoQM-Ta2UROCREiJdZw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:09:35 INFO - Fetch https://queue.taskcluster.net/v1/task/YDBNoQM-Ta2UROCREiJdZw/artifacts/public/build/target.common.tests.zip into memory 05:09:36 INFO - Content-Length response header: 72759070 05:09:36 INFO - Bytes received: 72759070 05:09:47 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:09:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YDBNoQM-Ta2UROCREiJdZw/artifacts/public/build/target.common.tests.zip 05:09:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YDBNoQM-Ta2UROCREiJdZw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:09:47 INFO - Fetch https://queue.taskcluster.net/v1/task/YDBNoQM-Ta2UROCREiJdZw/artifacts/public/build/target.common.tests.zip into memory 05:09:48 INFO - Content-Length response header: 72759070 05:09:48 INFO - Bytes received: 72759070 05:10:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YDBNoQM-Ta2UROCREiJdZw/artifacts/public/build/target.talos.tests.zip 05:10:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YDBNoQM-Ta2UROCREiJdZw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:10:01 INFO - Fetch https://queue.taskcluster.net/v1/task/YDBNoQM-Ta2UROCREiJdZw/artifacts/public/build/target.talos.tests.zip into memory 05:10:02 INFO - Content-Length response header: 14498965 05:10:02 INFO - Bytes received: 14498965 05:10: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')]} 05:10:02 INFO - trying https://queue.taskcluster.net/v1/task/YDBNoQM-Ta2UROCREiJdZw/artifacts/public/build/target.tar.bz2 05:10:02 INFO - Downloading https://queue.taskcluster.net/v1/task/YDBNoQM-Ta2UROCREiJdZw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:10:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YDBNoQM-Ta2UROCREiJdZw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:10:03 INFO - Downloaded 61871941 bytes. 05:10:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YDBNoQM-Ta2UROCREiJdZw/artifacts/public/build/target.tar.bz2 05:10:03 INFO - mkdir: /builds/slave/test/properties 05:10:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:10:03 INFO - Writing to file /builds/slave/test/properties/build_url 05:10:03 INFO - Contents: 05:10:03 INFO - build_url:https://queue.taskcluster.net/v1/task/YDBNoQM-Ta2UROCREiJdZw/artifacts/public/build/target.tar.bz2 05:10:03 INFO - Running post-action listener: _resource_record_post_action 05:10:03 INFO - Running post-action listener: set_extra_try_arguments 05:10:03 INFO - [mozharness: 2017-07-20 12:10:03.637925Z] Finished download-and-extract step (success) 05:10:03 INFO - [mozharness: 2017-07-20 12:10:03.638022Z] Running populate-webroot step. 05:10:03 INFO - Running pre-action listener: _resource_record_pre_action 05:10:03 INFO - Running main action method: populate_webroot 05:10:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:10:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:10:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:10:03 INFO - '--tppagecycles', 05:10:03 INFO - '7'], 05:10:03 INFO - 'tests': ['tsvgm']}}, 05:10:03 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:10:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:10:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:10:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:10:03 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:10:03 INFO - 'talos_options': ['--disable-e10s'], 05:10:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:10:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:10:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:10:03 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:10:03 INFO - 'talos_options': ['--disable-e10s'], 05:10:03 INFO - 'tests': ['damp', 'tps']}, 05:10:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:10:03 INFO - 'tests': ['damp', 'tps']}, 05:10:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:10:03 INFO - 'tests': ['dromaeo_dom']}, 05:10:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:10:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:10:03 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:10:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:10:03 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:10:03 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:10:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:10:03 INFO - 'tests': ['a11yr', 05:10:03 INFO - 'ts_paint', 05:10:03 INFO - 'tpaint', 05:10:03 INFO - 'sessionrestore', 05:10:03 INFO - 'sessionrestore_no_auto_restore', 05:10:03 INFO - 'tabpaint']}, 05:10:03 INFO - 'other-e10s': {'tests': ['a11yr', 05:10:03 INFO - 'ts_paint', 05:10:03 INFO - 'tpaint', 05:10:03 INFO - 'sessionrestore', 05:10:03 INFO - 'sessionrestore_many_windows', 05:10:03 INFO - 'sessionrestore_no_auto_restore', 05:10:03 INFO - 'tabpaint']}, 05:10:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:10:03 INFO - 'ts_paint', 05:10:03 INFO - 'tpaint', 05:10:03 INFO - 'sessionrestore', 05:10:03 INFO - 'sessionrestore_many_windows', 05:10:03 INFO - 'sessionrestore_no_auto_restore', 05:10:03 INFO - 'tabpaint']}, 05:10:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:10:03 INFO - 'ts_paint', 05:10:03 INFO - 'tpaint', 05:10:03 INFO - 'sessionrestore', 05:10:03 INFO - 'sessionrestore_many_windows', 05:10:03 INFO - 'sessionrestore_no_auto_restore', 05:10:03 INFO - 'tabpaint']}, 05:10:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:10:03 INFO - 'tests': ['a11yr', 05:10:03 INFO - 'ts_paint', 05:10:03 INFO - 'tpaint', 05:10:03 INFO - 'sessionrestore', 05:10:03 INFO - 'sessionrestore_no_auto_restore', 05:10:03 INFO - 'tabpaint']}, 05:10:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:10:03 INFO - 'tests': ['a11yr', 05:10:03 INFO - 'ts_paint', 05:10:03 INFO - 'tpaint', 05:10:03 INFO - 'sessionrestore', 05:10:03 INFO - 'sessionrestore_no_auto_restore', 05:10:03 INFO - 'tabpaint']}, 05:10:03 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 05:10:03 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 05:10:03 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 05:10:03 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:10:03 INFO - 'talos_options': ['--mitmproxy', 05:10:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:10:03 INFO - '--firstNonBlankPaint'], 05:10:03 INFO - 'tests': ['quantum_pageload_google', 05:10:03 INFO - 'quantum_pageload_youtube', 05:10:03 INFO - 'quantum_pageload_amazon', 05:10:03 INFO - 'quantum_pageload_facebook']}, 05:10:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:10:03 INFO - 'tests': ['tsvgx', 05:10:03 INFO - 'tsvgr_opacity', 05:10:03 INFO - 'tart', 05:10:03 INFO - 'tscrollx', 05:10:03 INFO - 'cart', 05:10:03 INFO - 'tsvg_static']}, 05:10:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:10:03 INFO - 'tsvgr_opacity', 05:10:03 INFO - 'tart', 05:10:03 INFO - 'tscrollx', 05:10:03 INFO - 'cart', 05:10:03 INFO - 'tsvg_static']}, 05:10:03 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:10:03 INFO - 'talos_options': ['--disable-e10s'], 05:10:03 INFO - 'tests': ['tp5o']}, 05:10:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:10:03 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:10:03 INFO - 'talos_options': ['--disable-e10s', 05:10:03 INFO - '--xperf_path', 05:10:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:10:03 INFO - 'tests': ['tp5n']}, 05:10:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:10:03 INFO - 'talos_options': ['--xperf_path', 05:10:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:10:03 INFO - 'tests': ['tp5n']}}, 05:10:03 INFO - 'talos.zip': {'path': '', 05:10:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:10:03 INFO - Running post-action listener: _resource_record_post_action 05:10:03 INFO - [mozharness: 2017-07-20 12:10:03.653214Z] Finished populate-webroot step (success) 05:10:03 INFO - [mozharness: 2017-07-20 12:10:03.653304Z] Running create-virtualenv step. 05:10:03 INFO - Running pre-action listener: _resource_record_pre_action 05:10:03 INFO - Running main action method: create_virtualenv 05:10:03 INFO - Creating virtualenv /builds/slave/test/build/venv 05:10:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:10:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:10:03 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:10:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:10:03 INFO - Using real prefix '/usr' 05:10:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:10:04 INFO - Installing distribute.............................................................................................................................................................................................done. 05:10:06 INFO - Installing pip.................done. 05:10:06 INFO - Return code: 0 05:10:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:10:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:10:06 INFO - Reading from file tmpfile_stdout 05:10:06 INFO - Output received: 05:10:06 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:10:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x164da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f0b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17edd10>, '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 0x17eec10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ef0c0>, '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': '438111f3d31ce799eff2119d000001bc-1500545008.302335-83748825', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:10:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:10:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:10:06 INFO - Using env: {'DISPLAY': ':0', 05:10:06 INFO - 'HOME': '/home/cltbld', 05:10:06 INFO - 'LANG': 'en_US.UTF-8', 05:10:06 INFO - 'LANGUAGE': 'en_US:en', 05:10:06 INFO - 'LOGNAME': 'cltbld', 05:10:06 INFO - 'MAIL': '/var/mail/cltbld', 05:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:06 INFO - 'MOZ_NO_REMOTE': '1', 05:10:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:06 INFO - 'NO_EM_RESTART': '1', 05:10:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:06 INFO - 'PWD': '/builds/slave/test', 05:10:06 INFO - 'SHELL': '/bin/bash', 05:10:06 INFO - 'SHLVL': '1', 05:10:06 INFO - 'TERM': 'linux', 05:10:06 INFO - 'TMOUT': '86400', 05:10:06 INFO - 'USER': 'cltbld', 05:10:06 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1500545008.302335-83748825', 05:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:06 INFO - '_': '/tools/buildbot/bin/python'} 05:10:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:10:06 INFO - Cleaning up... 05:10:07 INFO - Return code: 0 05:10:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:07 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 0x147f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x164da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f0b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17edd10>, '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 0x17eec10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ef0c0>, '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': '438111f3d31ce799eff2119d000001bc-1500545008.302335-83748825', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:10:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:10:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:10:07 INFO - Using env: {'DISPLAY': ':0', 05:10:07 INFO - 'HOME': '/home/cltbld', 05:10:07 INFO - 'LANG': 'en_US.UTF-8', 05:10:07 INFO - 'LANGUAGE': 'en_US:en', 05:10:07 INFO - 'LOGNAME': 'cltbld', 05:10:07 INFO - 'MAIL': '/var/mail/cltbld', 05:10:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:07 INFO - 'MOZ_NO_REMOTE': '1', 05:10:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:07 INFO - 'NO_EM_RESTART': '1', 05:10:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:07 INFO - 'PWD': '/builds/slave/test', 05:10:07 INFO - 'SHELL': '/bin/bash', 05:10:07 INFO - 'SHLVL': '1', 05:10:07 INFO - 'TERM': 'linux', 05:10:07 INFO - 'TMOUT': '86400', 05:10:07 INFO - 'USER': 'cltbld', 05:10:07 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1500545008.302335-83748825', 05:10:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:07 INFO - '_': '/tools/buildbot/bin/python'} 05:10:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:07 INFO - Downloading/unpacking psutil>=3.1.1 05:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:10:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:10:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:10:08 INFO - Installing collected packages: psutil 05:10:08 INFO - Running setup.py install for psutil 05:10:08 INFO - building 'psutil._psutil_linux' extension 05:10:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:10:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:10:09 INFO - building 'psutil._psutil_posix' extension 05:10:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:10:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:10:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:10:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:10:09 INFO - Successfully installed psutil 05:10:09 INFO - Cleaning up... 05:10:09 INFO - Return code: 0 05:10:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:10:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x164da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f0b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17edd10>, '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 0x17eec10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ef0c0>, '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': '438111f3d31ce799eff2119d000001bc-1500545008.302335-83748825', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:10:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:10:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:10:09 INFO - Using env: {'DISPLAY': ':0', 05:10:09 INFO - 'HOME': '/home/cltbld', 05:10:09 INFO - 'LANG': 'en_US.UTF-8', 05:10:09 INFO - 'LANGUAGE': 'en_US:en', 05:10:09 INFO - 'LOGNAME': 'cltbld', 05:10:09 INFO - 'MAIL': '/var/mail/cltbld', 05:10:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:09 INFO - 'MOZ_NO_REMOTE': '1', 05:10:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:09 INFO - 'NO_EM_RESTART': '1', 05:10:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:09 INFO - 'PWD': '/builds/slave/test', 05:10:09 INFO - 'SHELL': '/bin/bash', 05:10:09 INFO - 'SHLVL': '1', 05:10:09 INFO - 'TERM': 'linux', 05:10:09 INFO - 'TMOUT': '86400', 05:10:09 INFO - 'USER': 'cltbld', 05:10:09 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1500545008.302335-83748825', 05:10:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:09 INFO - '_': '/tools/buildbot/bin/python'} 05:10:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:10:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:10:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:10:11 INFO - Installing collected packages: mozsystemmonitor 05:10:11 INFO - Running setup.py install for mozsystemmonitor 05:10:11 INFO - Successfully installed mozsystemmonitor 05:10:11 INFO - Cleaning up... 05:10:11 INFO - Return code: 0 05:10:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:10:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x164da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f0b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17edd10>, '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 0x17eec10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ef0c0>, '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': '438111f3d31ce799eff2119d000001bc-1500545008.302335-83748825', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:10:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:10:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:10:11 INFO - Using env: {'DISPLAY': ':0', 05:10:11 INFO - 'HOME': '/home/cltbld', 05:10:11 INFO - 'LANG': 'en_US.UTF-8', 05:10:11 INFO - 'LANGUAGE': 'en_US:en', 05:10:11 INFO - 'LOGNAME': 'cltbld', 05:10:11 INFO - 'MAIL': '/var/mail/cltbld', 05:10:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:11 INFO - 'MOZ_NO_REMOTE': '1', 05:10:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:11 INFO - 'NO_EM_RESTART': '1', 05:10:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:11 INFO - 'PWD': '/builds/slave/test', 05:10:11 INFO - 'SHELL': '/bin/bash', 05:10:11 INFO - 'SHLVL': '1', 05:10:11 INFO - 'TERM': 'linux', 05:10:11 INFO - 'TMOUT': '86400', 05:10:11 INFO - 'USER': 'cltbld', 05:10:11 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1500545008.302335-83748825', 05:10:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:11 INFO - '_': '/tools/buildbot/bin/python'} 05:10:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:11 INFO - Downloading/unpacking jsonschema==2.5.1 05:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:10:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:12 INFO - Downloading functools32-3.2.3-2.tar.gz 05:10:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:10:12 INFO - warning: no files found matching '*.txt' 05:10:12 INFO - no previously-included directories found matching 'build' 05:10:12 INFO - no previously-included directories found matching 'dist' 05:10:12 INFO - no previously-included directories found matching '.git*' 05:10:12 INFO - Installing collected packages: jsonschema, functools32 05:10:12 INFO - Running setup.py install for functools32 05:10:12 INFO - warning: no files found matching '*.txt' 05:10:12 INFO - no previously-included directories found matching 'build' 05:10:12 INFO - no previously-included directories found matching 'dist' 05:10:12 INFO - no previously-included directories found matching '.git*' 05:10:12 INFO - Successfully installed jsonschema functools32 05:10:12 INFO - Cleaning up... 05:10:12 INFO - Return code: 0 05:10:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:12 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 0x147f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x164da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f0b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17edd10>, '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 0x17eec10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ef0c0>, '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': '438111f3d31ce799eff2119d000001bc-1500545008.302335-83748825', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:10:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:10:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:10:12 INFO - Using env: {'DISPLAY': ':0', 05:10:12 INFO - 'HOME': '/home/cltbld', 05:10:12 INFO - 'LANG': 'en_US.UTF-8', 05:10:12 INFO - 'LANGUAGE': 'en_US:en', 05:10:12 INFO - 'LOGNAME': 'cltbld', 05:10:12 INFO - 'MAIL': '/var/mail/cltbld', 05:10:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:12 INFO - 'MOZ_NO_REMOTE': '1', 05:10:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:12 INFO - 'NO_EM_RESTART': '1', 05:10:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:12 INFO - 'PWD': '/builds/slave/test', 05:10:12 INFO - 'SHELL': '/bin/bash', 05:10:12 INFO - 'SHLVL': '1', 05:10:12 INFO - 'TERM': 'linux', 05:10:12 INFO - 'TMOUT': '86400', 05:10:12 INFO - 'USER': 'cltbld', 05:10:12 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1500545008.302335-83748825', 05:10:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:12 INFO - '_': '/tools/buildbot/bin/python'} 05:10:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:10:13 INFO - Cleaning up... 05:10:13 INFO - Return code: 0 05:10:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x164da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f0b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17edd10>, '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 0x17eec10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ef0c0>, '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': '438111f3d31ce799eff2119d000001bc-1500545008.302335-83748825', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:10:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:10:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:10:13 INFO - Using env: {'DISPLAY': ':0', 05:10:13 INFO - 'HOME': '/home/cltbld', 05:10:13 INFO - 'LANG': 'en_US.UTF-8', 05:10:13 INFO - 'LANGUAGE': 'en_US:en', 05:10:13 INFO - 'LOGNAME': 'cltbld', 05:10:13 INFO - 'MAIL': '/var/mail/cltbld', 05:10:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:13 INFO - 'MOZ_NO_REMOTE': '1', 05:10:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:13 INFO - 'NO_EM_RESTART': '1', 05:10:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:13 INFO - 'PWD': '/builds/slave/test', 05:10:13 INFO - 'SHELL': '/bin/bash', 05:10:13 INFO - 'SHLVL': '1', 05:10:13 INFO - 'TERM': 'linux', 05:10:13 INFO - 'TMOUT': '86400', 05:10:13 INFO - 'USER': 'cltbld', 05:10:13 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1500545008.302335-83748825', 05:10:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:13 INFO - '_': '/tools/buildbot/bin/python'} 05:10:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:13 INFO - Downloading/unpacking blobuploader==1.2.4 05:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:14 INFO - Downloading blobuploader-1.2.4.tar.gz 05:10:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:10:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:10:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:15 INFO - Downloading docopt-0.6.1.tar.gz 05:10:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:10:15 INFO - Installing collected packages: blobuploader, requests, docopt 05:10:15 INFO - Running setup.py install for blobuploader 05:10:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:10:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:10:15 INFO - Running setup.py install for requests 05:10:15 INFO - Running setup.py install for docopt 05:10:15 INFO - Successfully installed blobuploader requests docopt 05:10:15 INFO - Cleaning up... 05:10:15 INFO - Return code: 0 05:10:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:15 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 0x147f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x164da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f0b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17edd10>, '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 0x17eec10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ef0c0>, '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': '438111f3d31ce799eff2119d000001bc-1500545008.302335-83748825', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:10:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:10:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:10:15 INFO - Using env: {'DISPLAY': ':0', 05:10:15 INFO - 'HOME': '/home/cltbld', 05:10:15 INFO - 'LANG': 'en_US.UTF-8', 05:10:15 INFO - 'LANGUAGE': 'en_US:en', 05:10:15 INFO - 'LOGNAME': 'cltbld', 05:10:15 INFO - 'MAIL': '/var/mail/cltbld', 05:10:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:15 INFO - 'MOZ_NO_REMOTE': '1', 05:10:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:15 INFO - 'NO_EM_RESTART': '1', 05:10:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:15 INFO - 'PWD': '/builds/slave/test', 05:10:15 INFO - 'SHELL': '/bin/bash', 05:10:15 INFO - 'SHLVL': '1', 05:10:15 INFO - 'TERM': 'linux', 05:10:15 INFO - 'TMOUT': '86400', 05:10:15 INFO - 'USER': 'cltbld', 05:10:15 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1500545008.302335-83748825', 05:10:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:15 INFO - '_': '/tools/buildbot/bin/python'} 05:10:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:10:15 INFO - Running setup.py (path:/tmp/pip-UZ1WqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:10:15 INFO - Running setup.py (path:/tmp/pip-Svw6Uz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:10:16 INFO - Running setup.py (path:/tmp/pip-YYmMuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:10:16 INFO - Running setup.py (path:/tmp/pip-1XP5na-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:10:16 INFO - Running setup.py (path:/tmp/pip-EpYLRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:10:16 INFO - Running setup.py (path:/tmp/pip-o0gr38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:10:16 INFO - Running setup.py (path:/tmp/pip-PyrYI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:10:16 INFO - Running setup.py (path:/tmp/pip-GAFmiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:10:16 INFO - Running setup.py (path:/tmp/pip-2fi8Bb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:10:16 INFO - Running setup.py (path:/tmp/pip-yXyUy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:10:16 INFO - Running setup.py (path:/tmp/pip-p0wXBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:10:16 INFO - Running setup.py (path:/tmp/pip-cZTjFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:10:16 INFO - Running setup.py (path:/tmp/pip-4cnmEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:10:16 INFO - Running setup.py (path:/tmp/pip-BO8vMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:16 INFO - Running setup.py (path:/tmp/pip-2kO32V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:10:16 INFO - Running setup.py (path:/tmp/pip-TBszrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:10:17 INFO - Running setup.py (path:/tmp/pip-tY2cYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:10:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:10:17 INFO - Running setup.py install for manifestparser 05:10:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:10:17 INFO - Running setup.py install for mozcrash 05:10:17 INFO - Running setup.py install for mozdebug 05:10:17 INFO - Running setup.py install for mozdevice 05:10:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:10:17 INFO - Running setup.py install for mozfile 05:10:17 INFO - Running setup.py install for mozhttpd 05:10:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:10:17 INFO - Running setup.py install for mozinfo 05:10:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:10:17 INFO - Running setup.py install for mozInstall 05:10:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:10:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:10:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:10:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:10:17 INFO - Running setup.py install for mozleak 05:10:17 INFO - Running setup.py install for mozlog 05:10:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:10:18 INFO - Running setup.py install for moznetwork 05:10:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:10:18 INFO - Running setup.py install for mozprocess 05:10:18 INFO - Running setup.py install for mozprofile 05:10:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:10:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:10:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:10:18 INFO - Running setup.py install for mozrunner 05:10:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:10:18 INFO - Running setup.py install for mozscreenshot 05:10:18 INFO - Running setup.py install for moztest 05:10:18 INFO - Running setup.py install for mozversion 05:10:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:10:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:10:18 INFO - Cleaning up... 05:10:18 INFO - Return code: 0 05:10:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:10:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:18 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 0x147f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x164da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f0b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17edd10>, '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 0x17eec10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ef0c0>, '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': '438111f3d31ce799eff2119d000001bc-1500545008.302335-83748825', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:10:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:10:18 INFO - Using env: {'DISPLAY': ':0', 05:10:18 INFO - 'HOME': '/home/cltbld', 05:10:18 INFO - 'LANG': 'en_US.UTF-8', 05:10:18 INFO - 'LANGUAGE': 'en_US:en', 05:10:18 INFO - 'LOGNAME': 'cltbld', 05:10:18 INFO - 'MAIL': '/var/mail/cltbld', 05:10:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:18 INFO - 'MOZ_NO_REMOTE': '1', 05:10:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:18 INFO - 'NO_EM_RESTART': '1', 05:10:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:18 INFO - 'PWD': '/builds/slave/test', 05:10:18 INFO - 'SHELL': '/bin/bash', 05:10:18 INFO - 'SHLVL': '1', 05:10:18 INFO - 'TERM': 'linux', 05:10:18 INFO - 'TMOUT': '86400', 05:10:18 INFO - 'USER': 'cltbld', 05:10:18 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1500545008.302335-83748825', 05:10:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:18 INFO - '_': '/tools/buildbot/bin/python'} 05:10:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:10:19 INFO - Running setup.py (path:/tmp/pip-tI53kR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:10:19 INFO - Running setup.py (path:/tmp/pip-vjg1nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:10:19 INFO - Running setup.py (path:/tmp/pip-5WmXi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:10:19 INFO - Running setup.py (path:/tmp/pip-zzuASB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:10:19 INFO - Running setup.py (path:/tmp/pip-vjrKhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:10:19 INFO - Running setup.py (path:/tmp/pip-iPr6J0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:10:19 INFO - Running setup.py (path:/tmp/pip-afQ280-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:10:19 INFO - Running setup.py (path:/tmp/pip-3fL0UO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:10:19 INFO - Running setup.py (path:/tmp/pip-m6dNzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:10:19 INFO - Running setup.py (path:/tmp/pip-OZcNuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:10:19 INFO - Running setup.py (path:/tmp/pip-p2PUSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:10:19 INFO - Running setup.py (path:/tmp/pip-eVNeCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:10:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:10:20 INFO - Running setup.py (path:/tmp/pip-0jY28i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:10:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:10:20 INFO - Running setup.py (path:/tmp/pip-aZgfbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:10:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:20 INFO - Running setup.py (path:/tmp/pip-XpFkhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:10:20 INFO - Running setup.py (path:/tmp/pip-wcB34j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:10:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:10:20 INFO - Running setup.py (path:/tmp/pip-0r8Y9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:10:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:10:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:10:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:10:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:10:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:10:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:10:20 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:10:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:21 INFO - Downloading blessings-1.6.tar.gz 05:10:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:10:21 INFO - Installing collected packages: blessings 05:10:21 INFO - Running setup.py install for blessings 05:10:21 INFO - Successfully installed blessings 05:10:21 INFO - Cleaning up... 05:10:21 INFO - Return code: 0 05:10:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:10:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:10:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:10:21 INFO - Reading from file tmpfile_stdout 05:10:21 INFO - Current package versions: 05:10:21 INFO - argparse == 1.2.1 05:10:21 INFO - blessings == 1.6 05:10:21 INFO - blobuploader == 1.2.4 05:10:21 INFO - docopt == 0.6.1 05:10:21 INFO - functools32 == 3.2.3-2 05:10:21 INFO - jsonschema == 2.5.1 05:10:21 INFO - manifestparser == 1.1 05:10:21 INFO - mozInstall == 1.13 05:10:21 INFO - mozcrash == 1.0 05:10:21 INFO - mozdebug == 0.1 05:10:21 INFO - mozdevice == 0.51 05:10:21 INFO - mozfile == 1.2 05:10:21 INFO - mozhttpd == 0.7 05:10:21 INFO - mozinfo == 0.10 05:10:21 INFO - mozleak == 0.1 05:10:21 INFO - mozlog == 3.5 05:10:21 INFO - moznetwork == 0.27 05:10:21 INFO - mozprocess == 0.25 05:10:21 INFO - mozprofile == 0.28 05:10:21 INFO - mozrunner == 6.13 05:10:21 INFO - mozscreenshot == 0.1 05:10:21 INFO - mozsystemmonitor == 0.3 05:10:21 INFO - moztest == 0.8 05:10:21 INFO - mozversion == 1.4 05:10:21 INFO - psutil == 3.1.1 05:10:21 INFO - requests == 1.2.3 05:10:21 INFO - wsgiref == 0.1.2 05:10:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:10:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:21 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 0x147f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x164da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f0b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17edd10>, '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 0x17eec10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ef0c0>, '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': '438111f3d31ce799eff2119d000001bc-1500545008.302335-83748825', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:10:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:10:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:10:21 INFO - Using env: {'DISPLAY': ':0', 05:10:21 INFO - 'HOME': '/home/cltbld', 05:10:21 INFO - 'LANG': 'en_US.UTF-8', 05:10:21 INFO - 'LANGUAGE': 'en_US:en', 05:10:21 INFO - 'LOGNAME': 'cltbld', 05:10:21 INFO - 'MAIL': '/var/mail/cltbld', 05:10:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:21 INFO - 'MOZ_NO_REMOTE': '1', 05:10:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:21 INFO - 'NO_EM_RESTART': '1', 05:10:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:21 INFO - 'PWD': '/builds/slave/test', 05:10:21 INFO - 'SHELL': '/bin/bash', 05:10:21 INFO - 'SHLVL': '1', 05:10:21 INFO - 'TERM': 'linux', 05:10:21 INFO - 'TMOUT': '86400', 05:10:21 INFO - 'USER': 'cltbld', 05:10:21 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1500545008.302335-83748825', 05:10:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:21 INFO - '_': '/tools/buildbot/bin/python'} 05:10:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:10:22 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:23 INFO - Downloading marionette_driver-1.4.0.tar.gz 05:10:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 05:10:23 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 05:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:10:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:10:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:10:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:10:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:10:23 INFO - Installing collected packages: marionette-driver, simplejson 05:10:23 INFO - Running setup.py install for marionette-driver 05:10:23 INFO - Running setup.py install for simplejson 05:10:23 INFO - building 'simplejson._speedups' extension 05:10:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 05:10:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 05:10:24 INFO - Successfully installed marionette-driver simplejson 05:10:24 INFO - Cleaning up... 05:10:24 INFO - Return code: 0 05:10:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x164da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f0b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17edd10>, '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 0x17eec10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ef0c0>, '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': '438111f3d31ce799eff2119d000001bc-1500545008.302335-83748825', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:10:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:10:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:10:24 INFO - Using env: {'DISPLAY': ':0', 05:10:24 INFO - 'HOME': '/home/cltbld', 05:10:24 INFO - 'LANG': 'en_US.UTF-8', 05:10:24 INFO - 'LANGUAGE': 'en_US:en', 05:10:24 INFO - 'LOGNAME': 'cltbld', 05:10:24 INFO - 'MAIL': '/var/mail/cltbld', 05:10:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:24 INFO - 'MOZ_NO_REMOTE': '1', 05:10:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:24 INFO - 'NO_EM_RESTART': '1', 05:10:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:24 INFO - 'PWD': '/builds/slave/test', 05:10:24 INFO - 'SHELL': '/bin/bash', 05:10:24 INFO - 'SHLVL': '1', 05:10:24 INFO - 'TERM': 'linux', 05:10:24 INFO - 'TMOUT': '86400', 05:10:24 INFO - 'USER': 'cltbld', 05:10:24 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1500545008.302335-83748825', 05:10:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:24 INFO - '_': '/tools/buildbot/bin/python'} 05:10:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:10:24 INFO - Cleaning up... 05:10:24 INFO - Return code: 0 05:10:24 INFO - Running post-action listener: _resource_record_post_action 05:10:24 INFO - Running post-action listener: _start_resource_monitoring 05:10:24 INFO - Starting resource monitoring. 05:10:24 INFO - [mozharness: 2017-07-20 12:10:24.991774Z] Finished create-virtualenv step (success) 05:10:24 INFO - [mozharness: 2017-07-20 12:10:24.992285Z] Running install step. 05:10:24 INFO - Running pre-action listener: _resource_record_pre_action 05:10:24 INFO - Running main action method: install 05:10:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:10:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:10:25 INFO - Reading from file tmpfile_stdout 05:10:25 INFO - Detecting whether we're running mozinstall >=1.0... 05:10:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:10:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:10:25 INFO - Reading from file tmpfile_stdout 05:10:25 INFO - Output received: 05:10:25 INFO - Usage: mozinstall [options] installer 05:10:25 INFO - Options: 05:10:25 INFO - -h, --help show this help message and exit 05:10:25 INFO - -d DEST, --destination=DEST 05:10:25 INFO - Directory to install application into. [default: 05:10:25 INFO - "/builds/slave/test"] 05:10:25 INFO - --app=APP Application being installed. [default: firefox] 05:10:25 INFO - mkdir: /builds/slave/test/build/application 05:10:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:10:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:10:43 INFO - Reading from file tmpfile_stdout 05:10:43 INFO - Output received: 05:10:43 INFO - /builds/slave/test/build/application/firefox/firefox 05:10:43 INFO - Running post-action listener: _resource_record_post_action 05:10:43 INFO - [mozharness: 2017-07-20 12:10:43.254665Z] Finished install step (success) 05:10:43 INFO - [mozharness: 2017-07-20 12:10:43.254915Z] Running setup-mitmproxy step. 05:10:43 INFO - Running pre-action listener: _resource_record_pre_action 05:10:43 INFO - Running main action method: setup_mitmproxy 05:10:43 INFO - Skipping: mitmproxy is not required 05:10:43 INFO - Running post-action listener: _resource_record_post_action 05:10:43 INFO - [mozharness: 2017-07-20 12:10:43.256033Z] Finished setup-mitmproxy step (success) 05:10:43 INFO - [mozharness: 2017-07-20 12:10:43.256270Z] Running run-tests step. 05:10:43 INFO - Running pre-action listener: _resource_record_pre_action 05:10:43 INFO - Running pre-action listener: _set_gcov_prefix 05:10:43 INFO - Running main action method: run_tests 05:10:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:10:43 INFO - Python 2.7.3 05:10:43 INFO - Return code: 0 05:10:43 INFO - grabbing minidump binary from tooltool 05:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:43 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17edd10>, '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 0x17eec10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ef0c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:10:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:10:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:10:43 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:10:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:10:43 INFO - Return code: 0 05:10:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:10:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:10:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:10:43 INFO - ENV: RUST_BACKTRACE is now 1 05:10:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:10:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:10:43 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/YDBNoQM-Ta2UROCREiJdZw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-086', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:10:43 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/YDBNoQM-Ta2UROCREiJdZw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-086 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:10:43 INFO - Using env: {'DISPLAY': ':0', 05:10:43 INFO - 'HOME': '/home/cltbld', 05:10:43 INFO - 'LANG': 'en_US.UTF-8', 05:10:43 INFO - 'LANGUAGE': 'en_US:en', 05:10:43 INFO - 'LOGNAME': 'cltbld', 05:10:43 INFO - 'MAIL': '/var/mail/cltbld', 05:10:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:10:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:10:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:43 INFO - 'MOZ_NO_REMOTE': '1', 05:10:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:10:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:43 INFO - 'NO_EM_RESTART': '1', 05:10:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:43 INFO - 'PWD': '/builds/slave/test', 05:10:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:10:43 INFO - 'RUST_BACKTRACE': '1', 05:10:43 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:10:43 INFO - 'SHELL': '/bin/bash', 05:10:43 INFO - 'SHLVL': '1', 05:10:43 INFO - 'TERM': 'linux', 05:10:43 INFO - 'TMOUT': '86400', 05:10:43 INFO - 'USER': 'cltbld', 05:10:43 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1500545008.302335-83748825', 05:10:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:43 INFO - '_': '/tools/buildbot/bin/python'} 05:10:43 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/YDBNoQM-Ta2UROCREiJdZw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-086', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:10:43 INFO - mozversion application_buildid: 20170720112422 05:10:43 INFO - mozversion application_changeset: 68046a58f82913eb7804e4796ec981f6f8ea490e 05:10:43 INFO - mozversion application_display_name: Nightly 05:10:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:10:43 INFO - mozversion application_name: Firefox 05:10:43 INFO - mozversion application_remotingname: firefox 05:10:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:10:43 INFO - mozversion application_vendor: Mozilla 05:10:43 INFO - mozversion application_version: 56.0a1 05:10:43 INFO - mozversion platform_buildid: 20170720112422 05:10:43 INFO - mozversion platform_changeset: 68046a58f82913eb7804e4796ec981f6f8ea490e 05:10:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:10:43 INFO - mozversion platform_version: 56.0a1 05:10:43 INFO - using testdate: 1500552643 05:10:43 INFO - actual date: 1500552643 05:10:43 INFO - starting webserver on 'localhost:47144' 05:10:43 INFO - SUITE-START | Running 2 tests 05:10:43 INFO - TEST-START | dromaeo_css 05:10:43 INFO - Initialising browser for dromaeo_css test... 05:10:43 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47144/getInfo.html -profile /tmp/tmp3SV6NO/profile 05:10:43 INFO - TEST-INFO | started process 3337 (/builds/slave/test/build/application/firefox/firefox http://localhost:47144/getInfo.html) 05:10:50 INFO - TEST-INFO | 3337: exit 0 05:10:51 INFO - Browser initialized. 05:10:51 INFO - Running cycle 1/1 for dromaeo_css test... 05:10:51 INFO - TEST-INFO | started process 3549 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3SV6NO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:11:02 INFO - PID 3549 | RSS: Main: 175853568 05:11:02 INFO - PID 3549 | 05:14:01 INFO - PID 3549 | Cycle 1(1): loaded http://localhost:47144/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47144/tests/dromaeo/cssquery-ext.html) 05:14:02 INFO - PID 3549 | RSS: Main: 178008064 05:14:02 INFO - PID 3549 | 05:17:04 INFO - PID 3549 | Cycle 1(1): loaded http://localhost:47144/tests/dromaeo/cssquery-ext.html (next: http://localhost:47144/tests/dromaeo/cssquery-jquery.html) 05:17:05 INFO - PID 3549 | RSS: Main: 176594944 05:17:05 INFO - PID 3549 | 05:20:07 INFO - PID 3549 | Cycle 1(1): loaded http://localhost:47144/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47144/tests/dromaeo/cssquery-mootools.html) 05:20:07 INFO - PID 3549 | RSS: Main: 175943680 05:20:07 INFO - PID 3549 | 05:23:09 INFO - PID 3549 | Cycle 1(1): loaded http://localhost:47144/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47144/tests/dromaeo/cssquery-prototype.html) 05:23:10 INFO - PID 3549 | RSS: Main: 176775168 05:23:10 INFO - PID 3549 | 05:26:14 INFO - PID 3549 | Cycle 1(1): loaded http://localhost:47144/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47144/tests/dromaeo/cssquery-yui.html) 05:26:14 INFO - PID 3549 | RSS: Main: 178331648 05:26:14 INFO - PID 3549 | 05:29:16 INFO - PID 3549 | Cycle 1(1): loaded http://localhost:47144/tests/dromaeo/cssquery-yui.html (next: http://localhost:47144/tests/dromaeo/cssquery-dojo.html) 05:29:16 INFO - PID 3549 | RSS: Main: 180133888 05:29:16 INFO - PID 3549 | 05:29:16 INFO - PID 3549 | __start_tp_report 05:29:16 INFO - PID 3549 | _x_x_mozilla_page_load 05:29:16 INFO - PID 3549 | _x_x_mozilla_page_load_details 05:29:16 INFO - PID 3549 | |i|pagename|runs| 05:29:16 INFO - PID 3549 | |0;dojo.html;3054.236440889777;3074.1853408846646;3090.0111964171465;3111.7977331473467;3131.6868313168684;5948.672822994734;6055.243094613179;6104.5116390688745;6142.570020098595;6157.846053848651;6015.639061656304;6037.39626037396;6055.0311950088;6059.787907423241;6074.271087469509;5482.205080263359;5525.668459892409;5571.052921003419;5603.8599035024245;5604.523615492668;5341.919871201935;5542.362628297757;5558.277423934903;5602.523785478239;5644.068728659787;5461.808836690717;5517.503424691797;5546.722663866791;5613.410591887875;5613.578981576398;5531.308586426697;5541.612087153901;5605.57958153136;5622.437756224344;5636.436356364372;5410.404855465896;5424.864378390533;5471.179323101566;5488.286522752017;5570.359408668014;5951.89889870371;5969.104634304846;5978.3124940631515;6008.579399442041;6050.27396712393;6394.584352017104;6402.847487452257;6481.287058423617;6494.577852439576;6497.18785151856;6436.3241859605005;6479.902801457982;6496.707648155844;6550;6561.80314590563;6018.909716354258;6089.939100609025;6102.0541816018585;6114.663693496856;6134.049222370495;6661.733530658817;6677.332266773381;6726.327367263235;6759.188897332253;6769.492288078413;6300.527460440485;6324.114623952651;6379.425851673372;6405.167328247391;6408.974564069819;6395;6481.449076828522;6482.902756458657;6485.54601177913;6490.156279683611;6339;6376.362363763679;6434.7104380303;6440.420362167428;6472.9029064564065;6340.651264180515;6434.967825160844;6454.2577603575255;6495.382938620824;6549.803505894831;5251.553617942442;5295.152775555893;5329.493698098752;5334.14653655421;5337;4531.3882625845745;4550.061053079131;4578.839740609063;4581.541845815392;4606.147862645421;5554.805581804618;5637.548996080303;5652.349979752381;5669.546436285087;5675.858103547444;6488.383603557749;6545.280019197884;6548.27968923418;6557.2131344239;6577.83555411109;5600.887982240414;5677.489025987681;5682.346530149003;5683.090705487102;5689.687067211343;5675.687837168995;5681.147827825859;5747.25285712863;5749.338826034976;5767.942320576824;6120.112583675342;6223.159873417121;6231.096491008779;6241.375862413813;6347.873042539123;6505.349465053457;6525.184351956005;6553.967230164009;6590.439812615789;6616.603003819786;6274.090256912631;6276.654783986742;6298.433141017331;6352.237731472253;6359.332270111571;6264.154339164154;6357.459615932513;6362.363763623601;6370.26741924666;6458.644774537445;6474.449671777952;6571.704273307808;6587.505937054644;6599.60402375859;6600.900986485302;6172;6198.256209254738;6272.874542509216;6350.523710721622;6352.714127864165;6230.252369715663;6259.123722678738;6289.308176100534;6298.779542715983;6309.148264984168;6275.215598050244;6285.779997700059;6287.308396076336;6298.275698294755;6312.905306420499;6224.906626400698;6317.210348706411;6328.936710632835;6353.3011368748475;6424.421802037839;6132.509399247961;6162.969185154046;6205.162303089025;6207.131001659862;6210.7515699371515 05:29:16 INFO - PID 3549 | |1;ext.html;814.6334149632663;852.4799872078031;879.9252063574596;884.7168905950094;1169.1056341898443;31342.216444588867;31838;41418.792906035465;42290;42324.78837605807;43056.13887722244;43338.34992475108;43346.78326608363;43515.12969740603;43521.782391088;7721.343685786715;7817.5309481431295;7883.881741773849;7887.408444366667;8042.195780421969;7846.215378462137;7905.841883162333;7953;7963.243491868263;7968.800779980489;7910.485818421813;7947.562884041376;7949.205079492062;7962.442629015971;7965.522068675869;7853.332466740334;7866.213378662117;7907;7923.445358824884;7950.045994480671;7749.806254843617;7841.568713720743;7841.686332546691;7846.097698764658;7850.057993040871;39094;39835;39871.40192897109;39877.40183897244;39941.60058399408;3570.6429357064344;3613.8373773180006;3614.8734794282072;3623.3296840084404;3623.5108260384773;32201.51697724536;32335;32483.187920301945;32491;32534.6746532534;4769.308450274691;4926.802927882881;4993.800247990076;5029.622778291643;5033.345665063518;194802;195064.99999999857;195926;195990;196274;49610.255846162334;49660;49704.75147624311;49711.50288497141;49934;52629.2105618416;52633;52850.207246891325;52946.470535294924;52960.470395296325;15393.923030385;15650.608734781494;15674.451394201149;15680.294386752623;15691.843081569266;10936.671899843017;11009.394483303335;12543.372831358396;12731.108822382344;12744.808827867404;15304.38782448712;15362.385504579692;15377.615559610875;15456.459023934109;15535.145566993699;6087.817365479043;6184.041473571604;6212.099245609452;6223.844403889939;6245.781397651152;988.8714467119229;1006.9697909062739;1012.6455740490769;1025.7179275699093;1027.5581499955092;22965.425864353525;29738.553921691193;30382;30474.085777426713;30844.383112337626;1080.783843231357;1100.2133474565724;1132.2413982631656;1133.795916734979;1149.804533229353;12351.135420520477;16069.196540172945;16085.732087227414;16204.055513338475;16557.91721041387;231504;235644;236627;237187;237299;59543.70228148832;60156.39843601508;60175.39824601698;60189.69905150534;60243;1501.2643804535699;1535;1535.3398038843181;1543.1281326050746;1551.2553974092498;27523.724762752117;27547.86226068857;28504.57243141313;28606.856965715036;28639.570406444338;53095.203571947226;53170.73414632902;53676.46323536871;53706;53754.73122634518;208790;210154;211397;211447;211851;37455.625443745215;38680.6131938677;39594.2081158381;39959.40060899147;40077;47234.52765472301;48756.756216218695;49049;49149.2627610579;49265.50734492609;33578.66421335755;34570.65429345674;34986.300273994886;35601.1099722509;35747.64252357443;33897.66102338945;34285.60066411819;34923.65076349204;35031.12422189466;35038;38689.80655096706;38740;38935.2212955745;39144.217115658095;39160.60839391684;31435.528467072556;32608.673913260565;33575.496367554995;33842.66157338494;34014.149646259044;23724.762752372255;24340.391490212885;24457.877710612043;24491.63262551099;25059.122930697336 05:29:16 INFO - PID 3549 | |2;jquery.html;569.3281927325756;574.3194314737037;579.2816907035277;590.1059894260195;595.2856572113463;22340.77659223409;22801.54396912061;23306.41733956652;23357.883210583943;23370.88314558427;25842.35394115148;26569;26589.335266618345;26660.466790664173;26731.86634066832;6456.806295811121;6617.371349721769;6628.4034436900665;6628.502862285348;6648;5990.49080828128;6523.9673801630925;6525.608463492182;6547.57440766351;6556.639384833832;6473.061406096113;6493.383128602799;6500.349965003509;6503.674816259192;6516.5112616553715;6483.935160648381;6500.707468163921;6513.576617519846;6521.804345869631;6530.183727034121;6053.909191362133;6058.666773327465;6070.332263451061;6073.544484163661;6074.696265186723;29225.415491690048;29443.852780736175;29821.10536683903;31428;31497.52753708696;1895.4976931113265;1940.2917934953641;1940.4857712706144;1941.175000624743;1941.932032378874;19114.426567202867;19332;19813.10841012158;19814.70277945832;20065.89637569933;2329.7320808107115;2369.597168481362;2388;2411.9879400602886;2471.6910386201725;140413.2979335097;143331.56668433285;143477;143492.28253858665;143859.28070359686;13946;14334.49829255992;14779.856920746432;15106.244687765568;15180.848191517944;23059.538809223723;23198.65202021971;23342;23395.298141055795;23468.64797028046;9653.613855445703;9697.951510242403;9907.801843963225;10000.649977250761;10015.14871235953;7805.2194780521495;8221.17788221185;9038.09619038091;9098.727038188865;9102.954485227532;8192.18078192176;9193.862092068624;9303.162715355515;9322.813543729088;9376.5311734413;2692.273086266697;2747.6565429321336;2793.706660800627;2795.65054368204;2825.39254060378;942.2697409507687;945.3571571331423;948.9372098705106;980.0983095552109;990.4354517924858;19480.220791168478;19705.310314138937;19755.40733777989;19874.906880121733;20480.897595511928;1012.2812802910016;1017.4556612212431;1023.5956797065118;1043.2540733375672;1049.4070849969742;10927.235093543375;13093.869061309455;13998.23009734454;14105.647358816112;14224.715505689828;442882;443977;444009;451146;455775;117938;120050;120419;121326.39336803436;121561;1273.2042473454092;1302.1796268351068;1305.4125643460482;1312.9934350328188;1318.1432069155126;20486.282980095624;20939.37181884546;21198.47003824855;21721.13115475363;22384.21655242059;55028.72485637706;55681.721591393405;55695.44304556902;56015;57339;65999;66194;66228;66366.33633663795;67105;11926.940365298118;12137.271763694207;12670.493180273055;14491.347889344794;14803;16779.496615101565;17328.740068899227;24255.51488970246;24279.757202428456;24586.13948511865;18992.43022709321;19068;19162.13770380364;19175.712364314266;19409.514762130493;15763.369465221263;16414.507564773077;17183;17236;17391.2173952175;20037.59924801525;20146.69779953331;20415.08132134028;20502.692459613416;20504.487387815425;14691.41234350614;14853.85146148568;14950.925245373703;14968;21701.240456583942;19345.806541934402;19869;20010.499737506096;20016.2994295199;20021.29925452602 05:29:16 INFO - PID 3549 | |3;mootools.html;1345.5088892554218;1405.1639274631593;1415.2923538230884;1424.095699230988;1428.7928250403693;12889;13480.325983700825;13503.594892153227;13550.864491355083;13560.3897824598;12909.096363254575;13862.930685346559;13939;13997.230152341617;14010.859891401084;2512.5226207020655;2556.18202175304;2562.3209849389928;2565.076572433922;2568.6147077938367;2533.037445770614;2544.37662772621;2604.335894346939;2657.7209393013745;2732.6037724529933;2653.615225792259;2673.037706425685;2683.6108764229175;2685.4494828560196;2692.623032775413;2257.548490301938;2323.2217207235594;2332.24202134307;2338.8362814602983;2338.97661023391;2469.703635563726;2498.0757119865766;2529.2665127113114;2534.569123249052;2536.289838845108;13335.333233338295;13486.662833429244;13533.39099740514;13560.389782459715;13812.792808107886;7071.328223818729;7276.781696549112;7283.635818209122;7376.815579610499;7383.778486645409;4591.403117594691;4713.6464765142755;4792.233242681189;4866.416030076413;4879.8780030499165;1862.7392165096896;1865.4776662534512;1878.1736036144189;1911.4074636862617;1915.090332092259;20800.47998800027;20875.37373878786;20924.79075209244;20957.68563471549;21037.68443473349;5774.740136693859;5983.970080149571;6099.024156134997;6143.662098584621;6163.96918015416;14928.70142597142;14935.17856517902;14940.252987350588;14992.925035374754;15016.699666006618;7103.396211322096;7233.782986510413;7254.96372518134;7261.7095316187815;7265.2371500992695;6278.811635650938;6644.700988455531;6655.0682904393425;6669.299723529057;6694.062831203635;4472.798724057425;4586.656000799953;4636.142313671981;4711.623070154379;4712.5994290485005;1196.2642974570576;1237.2761934268374;1258.1821815819608;1316.4997301025548;1364.3587513868465;890.5636238243214;921.8478950973015;923.4920793563513;932.9020452852488;941.2893265584577;7718.884216736754;7789;8005.159458256916;8198.508089514648;8290.792730181673;938.9342746007713;968.9273304502191;1010.8786945566579;1015.8171529124828;1029.156092004564;4133.8966525837095;4970.15507363749;5144.71704056273;5184.351956005499;5306.54894333986;17932.731009034876;18543.72184417235;18620;18632.534186645444;18650.440486785417;18023.909880450516;18195.727064094048;18198.909005454887;18245.908770456062;18298.908505457388;9824.263180261509;10460.058594726359;10666.94666526678;10682.51928663212;10689;7945.404094692805;8296.83406331858;8363.498190108612;8437.198466145706;8724.651013959625;15825.366985320457;16547.586310342336;16675.999440033636;16863.241154147847;17059.061751603782;16063.759043614122;16201.59496012609;16426.260818263447;16669.49991500257;16822.831771682126;10753.301035432673;11028.724281893017;11038;11047.447627618427;11071.058959988492;12512.562060327844;12529.436175371948;12663.240205587694;12696.555620553236;12778.169418987736;9972.451515166735;10472.319299245524;10592.205584581341;10662.413567253876;10673.46632668348;9727;9758.121769040821;10180.134688551556;10217.642382516577;10312.690619281433;9123.589438475152;9337;9409.200217981548;9426.057394260519;9435.575399107194;6833.692483838338;6992.860142797217;7037.120359955005;7210.134783825974;7245.166805817398;6854.828629284308;7318.926810731825;7332.523385980107;7396.55620662762;7485.88771168422 05:29:16 INFO - PID 3549 | |4;prototype.html;497.2292945933804;503.9218921067236;520.5419231076652;531.5534950641461;533.759808086361;6042.214512113419;6068.180795592599;6075.696215189239;6165.414285642868;6183.6598987055695;5955.761769529214;5967.49276311514;5983.521318294537;6011.639301641904;6112.816615501531;5092.541671249587;5100.693958362492;5117.667351622133;5128.461511541291;5161.251618515313;4983.825566105187;5076.949230507685;5093.083245015914;5119;5156.767945442445;5014.097462456756;5045.722485263309;5049.722265275427;5076.720780357079;5091.821786237482;5039.445660977308;5117.5650069744115;5128.205128205097;5162;5168.612354073422;4777.140114779339;4799.66402351832;4801.903961920742;4810.903781924377;4821.927671084936;6007.4893634041155;6010.2186715726675;6030.6080104793045;6039.184710064129;6081.594307187989;5853.64878107315;5866.882662346729;5869.882602347929;5885.676287804169;5914.319853216892;6473.756257431495;6500.609963402211;6556.114924485181;6580.506462015368;6589.703463344161;5228.660137091115;5254.133068043769;5291.206319052135;5291.973540132313;5307.548858347045;6753.932460675429;6755.324467553254;6796.830079248009;6811.182658081062;6887.351038049297;5330.760115794798;5345.705986170798;5372.328458942632;5403.621746477787;5436;5461.9453805462235;5498.780048798003;5510.476504732044;5516.475934786189;5525.806596769094;5795.971020144872;5871.033203876664;5898.380670029585;5953.053238646898;5978;6193.752249910043;6449.355064493607;6490.221173459215;6506.804795856132;6522.5760325578685;1806.1691621854095;1858.0895361272878;1911.8491696841054;1922.2503223742751;1930.5463216144194;1398.7482253194523;1407.8873690104767;1412.8092707484564;1422.7581311177125;1464.6924145929474;5487.341519017744;5593.3847276799515;5631.085430953495;5689.914651280152;5701.4013528579735;6500.252470965805;6506.642134682638;6570.685862827454;6577.967110164419;6591.2862655708905;5583.972080139573;5591.741858081899;5625.128105143709;5664.631798933056;5703.372629010805;3448.2758620689433;3531.8763843265874;3549.982250088733;3553.9289214216087;3558.7153027757718;6359.523035772336;6463.515236357292;6491.701659668085;6514.73941042353;6517.739290428424;6772.390484856386;6802.14973128359;6803.489738269551;6821.906855886428;6839.931600684029;6389.6805159741825;6391.58454700443;6405.711742971577;6460.25707043696;6478.352164783672;6620.172478440195;6646.501512386687;6677.131972843499;6686.364795344434;6686.531942764154;6526.608403495616;6542.037388783251;6549.8690026200165;6552.63960482159;6583.769568065286;6425.518086143651;6426.614403135827;6457.160569125984;6459;6474.805755827333;4923.064617722621;4926.458089610212;4937.5556199942175;4949.208126699711;4960.404751429852;6318.368163183829;6399.392057754506;6525.510586706111;6547.9672601636685;6659.733610655713;6268.561200715906;6377.7767778127545;6380.266269378895;6385.968070159805;6468.223813142453;6276.650520138192;6349.333320001518;6400.487960963019;6424.325445828307;6428.357164283534;6202.503799696104;6308.400701933309;6311;6335.493160547053;6369.649669268049;6435.742570297323;6477.611343319416;6479.384458476437;6526.379993900572;6536.215654121345;6196.380361963767;6247.406496382836;6278.46633036197;6284.366064823087;6306.369363063657 05:29:16 INFO - PID 3549 | |5;yui.html;912.2838571721201;916.2990312411007;923.9353245272829;933.3046880074346;942.4486675294952;15773.290201940912;16821.41125060623;16823.91588042058;16840.410585629506;18420;20730.689039664416;22052.8897355513;22188;22213.777862221414;22306.665400019014;1023.4064242739212;1054.051353781599;1061.1139698351885;1061.7929503746773;1061.8035663402295;970.1511177719495;1047.0576481166934;1054.0618849224197;1054.219877290807;1054.9050585447308;1063.5161001744189;1103;1111.111111111108;1111.7053980695123;1112.1325366214326;1100.8954149355839;1101.3557069114577;1103.2828661370174;1103.448275862069;1104.7845670094375;808.6644042722263;808.8584497712877;808.9878651820227;809.1018968944467;810.1331575214523;16962.23669934856;17390.826091739047;17492.12539373026;17600;17615.295388184586;20661.8966905166;20866.686999695015;21053.47366315839;21248.25631102904;21318.253861114943;16012.959157654715;16251.02493850361;16538.007719536865;16556.254968526446;16559.668806623922;3553.431450967833;3604.062943634674;3620.6379362063844;3631.1466805300734;3632.691221246197;123761;125413;129533;130730.3463482686;132074.3396283022;15498;16106.355745770272;16587.91706041486;16674.333026678796;16765.497035088967;28597.285067873054;30385.24036899051;31312.06063818089;31434.84282578618;31528.684713153034;8396.664133434717;8547.829043419097;8556.101609331055;8561.52911589856;8572.099929507436;4181.874543763692;4271.487421509377;4285.271503844354;4296.462942132233;4297.82808687649;5003.774830132653;5187.610929180327;5296.3379577552805;5301.814436494781;5308.230306605597;919.3426699909596;939.5020639061308;943.7876477792441;951.1107114847501;951.6526467839188;626.2985456288985;639.7057353617388;654.5974225851163;663.8074958262147;668.7258224128084;11378.772424551462;13323.866761332456;13587.728245435233;13622.795658065137;13759.587212383645;676.7462201674372;693.0747452151334;709.9112610923635;717.3113810741746;725.8802297620939;5533.7786488540005;5540.529055030287;5828.475437210586;5908.586398952032;6344.016677415008;93005;93323.0667693328;95865.52067239619;98886.50556747314;101885.49057254667;90068.5496572526;91166.54416728007;92745;92784;94725;74648;76696;77813.61093194498;80416.19583804204;82697.58651206705;11824.40877956116;12330.691732706755;12742.235465872078;12763.680907977376;13085.738285234433;35648.64351356453;36405.27189456143;36880.631193688794;37858.43212351762;37990.81004594959;63968;66136.6693166531;66930;67093;68220.6588967052;19412.126454309873;19704.113314900576;19709.507262317984;19753.40739777809;20092.799072009093;20731.792682072984;21592.35222943314;21827;21829.454263643536;22146.77853221447;18645.533861653566;18658.06709664484;18834.434966950466;18914.810851891303;19189.232430702614;20168.49578760543;20299.08654110539;20472.385828425173;20692.379228623166;20907.1637134519;19752.604947901247;19941.302054428026;20263.29078482246;20462.693059604415;20567.58864822725;11605.76788464243;12123.090768192596;12167.634970950885;12666.493340266286;12775.80836287475;14215.218163001135;14228.217448040457;14296.499622513162;14353.641158970691;14478.927605361905 05:29:16 INFO - PID 3549 | __end_tp_report 05:29:16 INFO - PID 3549 | __start_cc_report 05:29:16 INFO - PID 3549 | _x_x_mozilla_cycle_collect,377 05:29:16 INFO - PID 3549 | __end_cc_report 05:29:16 INFO - PID 3549 | __startTimestamp1500553756677__endTimestamp 05:29:16 INFO - PID 3549 | 05:29:16 INFO - PID 3549 | ------- Summary: start ------- 05:29:16 INFO - PID 3549 | Number of tests: 6 05:29:16 INFO - PID 3549 | 05:29:16 INFO - PID 3549 | [#0] dojo.html Cycles:165 Average:5976.51 Median:6210.75 stddev:692.48 (11.1%) stddev-sans-first:655.56 05:29:16 INFO - PID 3549 | Values: 3054.2 3074.2 3090.0 3111.8 3131.7 5948.7 6055.2 6104.5 6142.6 6157.8 6015.6 6037.4 6055.0 6059.8 6074.3 5482.2 5525.7 5571.1 5603.9 5604.5 5341.9 5542.4 5558.3 5602.5 5644.1 5461.8 5517.5 5546.7 5613.4 5613.6 5531.3 5541.6 5605.6 5622.4 5636.4 5410.4 5424.9 5471.2 5488.3 5570.4 5951.9 5969.1 5978.3 6008.6 6050.3 6394.6 6402.8 6481.3 6494.6 6497.2 6436.3 6479.9 6496.7 6550.0 6561.8 6018.9 6089.9 6102.1 6114.7 6134.0 6661.7 6677.3 6726.3 6759.2 6769.5 6300.5 6324.1 6379.4 6405.2 6409.0 6395.0 6481.4 6482.9 6485.5 6490.2 6339.0 6376.4 6434.7 6440.4 6472.9 6340.7 6435.0 6454.3 6495.4 6549.8 5251.6 5295.2 5329.5 5334.1 5337.0 4531.4 4550.1 4578.8 4581.5 4606.1 5554.8 5637.5 5652.3 5669.5 5675.9 6488.4 6545.3 6548.3 6557.2 6577.8 5600.9 5677.5 5682.3 5683.1 5689.7 5675.7 5681.1 5747.3 5749.3 5767.9 6120.1 6223.2 6231.1 6241.4 6347.9 6505.3 6525.2 6554.0 6590.4 6616.6 6274.1 6276.7 6298.4 6352.2 6359.3 6264.2 6357.5 6362.4 6370.3 6458.6 6474.4 6571.7 6587.5 6599.6 6600.9 6172.0 6198.3 6272.9 6350.5 6352.7 6230.3 6259.1 6289.3 6298.8 6309.1 6275.2 6285.8 6287.3 6298.3 6312.9 6224.9 6317.2 6328.9 6353.3 6424.4 6132.5 6163.0 6205.2 6207.1 6210.8 05:29:16 INFO - PID 3549 | 05:29:16 INFO - PID 3549 | [#1] ext.html Cycles:180 Average:39987.15 Median:3623.42 stddev:55624.61 (1535.1%) stddev-sans-first:55702.88 05:29:16 INFO - PID 3549 | Values: 814.6 852.5 879.9 884.7 1169.1 31342.2 31838.0 41418.8 42290.0 42324.8 43056.1 43338.3 43346.8 43515.1 43521.8 7721.3 7817.5 7883.9 7887.4 8042.2 7846.2 7905.8 7953.0 7963.2 7968.8 7910.5 7947.6 7949.2 7962.4 7965.5 7853.3 7866.2 7907.0 7923.4 7950.0 7749.8 7841.6 7841.7 7846.1 7850.1 39094.0 39835.0 39871.4 39877.4 39941.6 3570.6 3613.8 3614.9 3623.3 3623.5 32201.5 32335.0 32483.2 32491.0 32534.7 4769.3 4926.8 4993.8 5029.6 5033.3 194802.0 195065.0 195926.0 195990.0 196274.0 49610.3 49660.0 49704.8 49711.5 49934.0 52629.2 52633.0 52850.2 52946.5 52960.5 15393.9 15650.6 15674.5 15680.3 15691.8 10936.7 11009.4 12543.4 12731.1 12744.8 15304.4 15362.4 15377.6 15456.5 15535.1 6087.8 6184.0 6212.1 6223.8 6245.8 988.9 1007.0 1012.6 1025.7 1027.6 22965.4 29738.6 30382.0 30474.1 30844.4 1080.8 1100.2 1132.2 1133.8 1149.8 12351.1 16069.2 16085.7 16204.1 16557.9 231504.0 235644.0 236627.0 237187.0 237299.0 59543.7 60156.4 60175.4 60189.7 60243.0 1501.3 1535.0 1535.3 1543.1 1551.3 27523.7 27547.9 28504.6 28606.9 28639.6 53095.2 53170.7 53676.5 53706.0 53754.7 208790.0 210154.0 211397.0 211447.0 211851.0 37455.6 38680.6 39594.2 39959.4 40077.0 47234.5 48756.8 49049.0 49149.3 49265.5 33578.7 34570.7 34986.3 35601.1 35747.6 33897.7 34285.6 34923.7 35031.1 35038.0 38689.8 38740.0 38935.2 39144.2 39160.6 31435.5 32608.7 33575.5 33842.7 34014.1 23724.8 24340.4 24457.9 24491.6 25059.1 05:29:16 INFO - PID 3549 | 05:29:16 INFO - PID 3549 | [#2] jquery.html Cycles:180 Average:33961.07 Median:23349.94 stddev:76300.80 (326.8%) stddev-sans-first:76473.65 05:29:16 INFO - PID 3549 | Values: 569.3 574.3 579.3 590.1 595.3 22340.8 22801.5 23306.4 23357.9 23370.9 25842.4 26569.0 26589.3 26660.5 26731.9 6456.8 6617.4 6628.4 6628.5 6648.0 5990.5 6524.0 6525.6 6547.6 6556.6 6473.1 6493.4 6500.3 6503.7 6516.5 6483.9 6500.7 6513.6 6521.8 6530.2 6053.9 6058.7 6070.3 6073.5 6074.7 29225.4 29443.9 29821.1 31428.0 31497.5 1895.5 1940.3 1940.5 1941.2 1941.9 19114.4 19332.0 19813.1 19814.7 20065.9 2329.7 2369.6 2388.0 2412.0 2471.7 140413.3 143331.6 143477.0 143492.3 143859.3 13946.0 14334.5 14779.9 15106.2 15180.8 23059.5 23198.7 23342.0 23395.3 23468.6 9653.6 9698.0 9907.8 10000.6 10015.1 7805.2 8221.2 9038.1 9098.7 9103.0 8192.2 9193.9 9303.2 9322.8 9376.5 2692.3 2747.7 2793.7 2795.7 2825.4 942.3 945.4 948.9 980.1 990.4 19480.2 19705.3 19755.4 19874.9 20480.9 1012.3 1017.5 1023.6 1043.3 1049.4 10927.2 13093.9 13998.2 14105.6 14224.7 442882.0 443977.0 444009.0 451146.0 455775.0 117938.0 120050.0 120419.0 121326.4 121561.0 1273.2 1302.2 1305.4 1313.0 1318.1 20486.3 20939.4 21198.5 21721.1 22384.2 55028.7 55681.7 55695.4 56015.0 57339.0 65999.0 66194.0 66228.0 66366.3 67105.0 11926.9 12137.3 12670.5 14491.3 14803.0 16779.5 17328.7 24255.5 24279.8 24586.1 18992.4 19068.0 19162.1 19175.7 19409.5 15763.4 16414.5 17183.0 17236.0 17391.2 20037.6 20146.7 20415.1 20502.7 20504.5 14691.4 14853.9 14950.9 14968.0 21701.2 19345.8 19869.0 20010.5 20016.3 20021.3 05:29:16 INFO - PID 3549 | 05:29:16 INFO - PID 3549 | [#3] mootools.html Cycles:180 Average:8375.90 Median:2505.30 stddev:5608.61 (223.9%) stddev-sans-first:5599.46 05:29:16 INFO - PID 3549 | Values: 1345.5 1405.2 1415.3 1424.1 1428.8 12889.0 13480.3 13503.6 13550.9 13560.4 12909.1 13862.9 13939.0 13997.2 14010.9 2512.5 2556.2 2562.3 2565.1 2568.6 2533.0 2544.4 2604.3 2657.7 2732.6 2653.6 2673.0 2683.6 2685.4 2692.6 2257.5 2323.2 2332.2 2338.8 2339.0 2469.7 2498.1 2529.3 2534.6 2536.3 13335.3 13486.7 13533.4 13560.4 13812.8 7071.3 7276.8 7283.6 7376.8 7383.8 4591.4 4713.6 4792.2 4866.4 4879.9 1862.7 1865.5 1878.2 1911.4 1915.1 20800.5 20875.4 20924.8 20957.7 21037.7 5774.7 5984.0 6099.0 6143.7 6164.0 14928.7 14935.2 14940.3 14992.9 15016.7 7103.4 7233.8 7255.0 7261.7 7265.2 6278.8 6644.7 6655.1 6669.3 6694.1 4472.8 4586.7 4636.1 4711.6 4712.6 1196.3 1237.3 1258.2 1316.5 1364.4 890.6 921.8 923.5 932.9 941.3 7718.9 7789.0 8005.2 8198.5 8290.8 938.9 968.9 1010.9 1015.8 1029.2 4133.9 4970.2 5144.7 5184.4 5306.5 17932.7 18543.7 18620.0 18632.5 18650.4 18023.9 18195.7 18198.9 18245.9 18298.9 9824.3 10460.1 10666.9 10682.5 10689.0 7945.4 8296.8 8363.5 8437.2 8724.7 15825.4 16547.6 16676.0 16863.2 17059.1 16063.8 16201.6 16426.3 16669.5 16822.8 10753.3 11028.7 11038.0 11047.4 11071.1 12512.6 12529.4 12663.2 12696.6 12778.2 9972.5 10472.3 10592.2 10662.4 10673.5 9727.0 9758.1 10180.1 10217.6 10312.7 9123.6 9337.0 9409.2 9426.1 9435.6 6833.7 6992.9 7037.1 7210.1 7245.2 6854.8 7318.9 7332.5 7396.6 7485.9 05:29:16 INFO - PID 3549 | 05:29:16 INFO - PID 3549 | [#4] prototype.html Cycles:180 Average:5522.31 Median:6021.12 stddev:1472.14 (24.4%) stddev-sans-first:1427.13 05:29:16 INFO - PID 3549 | Values: 497.2 503.9 520.5 531.6 533.8 6042.2 6068.2 6075.7 6165.4 6183.7 5955.8 5967.5 5983.5 6011.6 6112.8 5092.5 5100.7 5117.7 5128.5 5161.3 4983.8 5076.9 5093.1 5119.0 5156.8 5014.1 5045.7 5049.7 5076.7 5091.8 5039.4 5117.6 5128.2 5162.0 5168.6 4777.1 4799.7 4801.9 4810.9 4821.9 6007.5 6010.2 6030.6 6039.2 6081.6 5853.6 5866.9 5869.9 5885.7 5914.3 6473.8 6500.6 6556.1 6580.5 6589.7 5228.7 5254.1 5291.2 5292.0 5307.5 6753.9 6755.3 6796.8 6811.2 6887.4 5330.8 5345.7 5372.3 5403.6 5436.0 5461.9 5498.8 5510.5 5516.5 5525.8 5796.0 5871.0 5898.4 5953.1 5978.0 6193.8 6449.4 6490.2 6506.8 6522.6 1806.2 1858.1 1911.8 1922.3 1930.5 1398.7 1407.9 1412.8 1422.8 1464.7 5487.3 5593.4 5631.1 5689.9 5701.4 6500.3 6506.6 6570.7 6578.0 6591.3 5584.0 5591.7 5625.1 5664.6 5703.4 3448.3 3531.9 3550.0 3553.9 3558.7 6359.5 6463.5 6491.7 6514.7 6517.7 6772.4 6802.1 6803.5 6821.9 6839.9 6389.7 6391.6 6405.7 6460.3 6478.4 6620.2 6646.5 6677.1 6686.4 6686.5 6526.6 6542.0 6549.9 6552.6 6583.8 6425.5 6426.6 6457.2 6459.0 6474.8 4923.1 4926.5 4937.6 4949.2 4960.4 6318.4 6399.4 6525.5 6548.0 6659.7 6268.6 6377.8 6380.3 6386.0 6468.2 6276.7 6349.3 6400.5 6424.3 6428.4 6202.5 6308.4 6311.0 6335.5 6369.6 6435.7 6477.6 6479.4 6526.4 6536.2 6196.4 6247.4 6278.5 6284.4 6306.4 05:29:16 INFO - PID 3549 | 05:29:16 INFO - PID 3549 | [#5] yui.html Cycles:180 Average:23018.52 Median:21283.26 stddev:30406.93 (142.9%) stddev-sans-first:30446.92 05:29:16 INFO - PID 3549 | Values: 912.3 916.3 923.9 933.3 942.4 15773.3 16821.4 16823.9 16840.4 18420.0 20730.7 22052.9 22188.0 22213.8 22306.7 1023.4 1054.1 1061.1 1061.8 1061.8 970.2 1047.1 1054.1 1054.2 1054.9 1063.5 1103.0 1111.1 1111.7 1112.1 1100.9 1101.4 1103.3 1103.4 1104.8 808.7 808.9 809.0 809.1 810.1 16962.2 17390.8 17492.1 17600.0 17615.3 20661.9 20866.7 21053.5 21248.3 21318.3 16013.0 16251.0 16538.0 16556.3 16559.7 3553.4 3604.1 3620.6 3631.1 3632.7 123761.0 125413.0 129533.0 130730.3 132074.3 15498.0 16106.4 16587.9 16674.3 16765.5 28597.3 30385.2 31312.1 31434.8 31528.7 8396.7 8547.8 8556.1 8561.5 8572.1 4181.9 4271.5 4285.3 4296.5 4297.8 5003.8 5187.6 5296.3 5301.8 5308.2 919.3 939.5 943.8 951.1 951.7 626.3 639.7 654.6 663.8 668.7 11378.8 13323.9 13587.7 13622.8 13759.6 676.7 693.1 709.9 717.3 725.9 5533.8 5540.5 5828.5 5908.6 6344.0 93005.0 93323.1 95865.5 98886.5 101885.5 90068.5 91166.5 92745.0 92784.0 94725.0 74648.0 76696.0 77813.6 80416.2 82697.6 11824.4 12330.7 12742.2 12763.7 13085.7 35648.6 36405.3 36880.6 37858.4 37990.8 63968.0 66136.7 66930.0 67093.0 68220.7 19412.1 19704.1 19709.5 19753.4 20092.8 20731.8 21592.4 21827.0 21829.5 22146.8 18645.5 18658.1 18834.4 18914.8 19189.2 20168.5 20299.1 20472.4 20692.4 20907.2 19752.6 19941.3 20263.3 20462.7 20567.6 11605.8 12123.1 12167.6 12666.5 12775.8 14215.2 14228.2 14296.5 14353.6 14478.9 05:29:16 INFO - PID 3549 | -------- Summary: end -------- 05:29:16 INFO - PID 3549 | 05:29:17 INFO - TEST-INFO | 3549: exit 0 05:29:17 INFO - TEST-OK | dromaeo_css | took 1113682ms 05:29:17 INFO - TEST-START | kraken 05:29:17 INFO - Initialising browser for kraken test... 05:29:17 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47144/getInfo.html -profile /tmp/tmpk3qRmt/profile 05:29:17 INFO - TEST-INFO | started process 3908 (/builds/slave/test/build/application/firefox/firefox http://localhost:47144/getInfo.html) 05:29:23 INFO - TEST-INFO | 3908: exit 0 05:29:23 INFO - Browser initialized. 05:29:23 INFO - Running cycle 1/1 for kraken test... 05:29:23 INFO - TEST-INFO | started process 4127 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk3qRmt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:29:34 INFO - PID 4127 | RSS: Main: 173064192 05:29:34 INFO - PID 4127 | 05:29:37 INFO - PID 4127 | Cycle 1(1): loaded http://localhost:47144/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47144/tests/kraken/driver.html?testName=audio-beat-detection) 05:29:38 INFO - PID 4127 | RSS: Main: 177139712 05:29:38 INFO - PID 4127 | 05:29:40 INFO - PID 4127 | Cycle 1(1): loaded http://localhost:47144/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47144/tests/kraken/driver.html?testName=audio-dft) 05:29:41 INFO - PID 4127 | RSS: Main: 177381376 05:29:41 INFO - PID 4127 | 05:29:44 INFO - PID 4127 | Cycle 1(1): loaded http://localhost:47144/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47144/tests/kraken/driver.html?testName=audio-fft) 05:29:45 INFO - PID 4127 | RSS: Main: 171663360 05:29:45 INFO - PID 4127 | 05:29:47 INFO - PID 4127 | Cycle 1(1): loaded http://localhost:47144/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47144/tests/kraken/driver.html?testName=audio-oscillator) 05:29:47 INFO - PID 4127 | RSS: Main: 172232704 05:29:47 INFO - PID 4127 | 05:29:50 INFO - PID 4127 | Cycle 1(1): loaded http://localhost:47144/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47144/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:29:50 INFO - PID 4127 | RSS: Main: 172478464 05:29:50 INFO - PID 4127 | 05:29:53 INFO - PID 4127 | Cycle 1(1): loaded http://localhost:47144/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47144/tests/kraken/driver.html?testName=imaging-darkroom) 05:29:54 INFO - PID 4127 | RSS: Main: 174956544 05:29:54 INFO - PID 4127 | 05:29:57 INFO - PID 4127 | Cycle 1(1): loaded http://localhost:47144/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47144/tests/kraken/driver.html?testName=imaging-desaturate) 05:29:58 INFO - PID 4127 | RSS: Main: 175235072 05:29:58 INFO - PID 4127 | 05:30:01 INFO - PID 4127 | Cycle 1(1): loaded http://localhost:47144/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47144/tests/kraken/driver.html?testName=json-parse-financial) 05:30:02 INFO - PID 4127 | RSS: Main: 175812608 05:30:02 INFO - PID 4127 | 05:30:03 INFO - PID 4127 | Cycle 1(1): loaded http://localhost:47144/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47144/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:30:04 INFO - PID 4127 | RSS: Main: 176185344 05:30:04 INFO - PID 4127 | 05:30:06 INFO - PID 4127 | Cycle 1(1): loaded http://localhost:47144/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47144/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:30:06 INFO - PID 4127 | RSS: Main: 176082944 05:30:06 INFO - PID 4127 | 05:30:08 INFO - PID 4127 | Cycle 1(1): loaded http://localhost:47144/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47144/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:30:09 INFO - PID 4127 | RSS: Main: 175824896 05:30:09 INFO - PID 4127 | 05:30:12 INFO - PID 4127 | Cycle 1(1): loaded http://localhost:47144/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47144/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:30:12 INFO - PID 4127 | RSS: Main: 176312320 05:30:12 INFO - PID 4127 | 05:30:16 INFO - PID 4127 | Cycle 1(1): loaded http://localhost:47144/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47144/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:30:16 INFO - PID 4127 | RSS: Main: 176369664 05:30:16 INFO - PID 4127 | 05:30:18 INFO - PID 4127 | Cycle 1(1): loaded http://localhost:47144/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47144/tests/kraken/driver.html?testName=ai-astar) 05:30:18 INFO - PID 4127 | RSS: Main: 178155520 05:30:18 INFO - PID 4127 | 05:30:18 INFO - PID 4127 | __start_tp_report 05:30:18 INFO - PID 4127 | _x_x_mozilla_page_load 05:30:18 INFO - PID 4127 | _x_x_mozilla_page_load_details 05:30:18 INFO - PID 4127 | |i|pagename|runs| 05:30:18 INFO - PID 4127 | |0;ai-astar;100;111;106;109;112;117;109;100;110;111 05:30:18 INFO - PID 4127 | |1;audio-beat-detection;144;124;143;182;120;144;143;126;170;122 05:30:18 INFO - PID 4127 | |2;audio-dft;165;163;171;163;163;163;163;175;164;163 05:30:18 INFO - PID 4127 | |3;audio-fft;78;76;77;166;75;74;74;92;99;83 05:30:18 INFO - PID 4127 | |4;audio-oscillator;82;81;138;81;82;82;129;81;81;129 05:30:18 INFO - PID 4127 | |5;imaging-gaussian-blur;113;115;115;114;114;113;114;117;114;114 05:30:18 INFO - PID 4127 | |6;imaging-darkroom;151;150;151;150;151;151;149;151;152;151 05:30:18 INFO - PID 4127 | |7;imaging-desaturate;94;94;93;94;95;97;95;95;94;97 05:30:18 INFO - PID 4127 | |8;json-parse-financial;54;55;53;54;53;56;54;61;54;54 05:30:18 INFO - PID 4127 | |9;json-stringify-tinderbox;54;54;54;55;55;54;55;54;55;54 05:30:18 INFO - PID 4127 | |10;stanford-crypto-aes;78;78;88;79;86;87;78;79;91;79 05:30:18 INFO - PID 4127 | |11;stanford-crypto-ccm;137;153;135;143;128;124;126;126;133;184 05:30:18 INFO - PID 4127 | |12;stanford-crypto-pbkdf2;177;177;192;182;182;190;177;179;179;179 05:30:18 INFO - PID 4127 | |13;stanford-crypto-sha256-iterative;71;71;67;73;68;69;68;70;68;69 05:30:18 INFO - PID 4127 | __end_tp_report 05:30:18 INFO - PID 4127 | __start_cc_report 05:30:18 INFO - PID 4127 | _x_x_mozilla_cycle_collect,933 05:30:18 INFO - PID 4127 | __end_cc_report 05:30:18 INFO - PID 4127 | __startTimestamp1500553818692__endTimestamp 05:30:18 INFO - PID 4127 | 05:30:18 INFO - PID 4127 | ------- Summary: start ------- 05:30:18 INFO - PID 4127 | Number of tests: 14 05:30:18 INFO - PID 4127 | 05:30:18 INFO - PID 4127 | [#0] ai-astar Cycles:10 Average:108.50 Median:110.50 stddev:5.28 (4.8%) stddev-sans-first:4.61 05:30:18 INFO - PID 4127 | Values: 100.0 111.0 106.0 109.0 112.0 117.0 109.0 100.0 110.0 111.0 05:30:18 INFO - PID 4127 | 05:30:18 INFO - PID 4127 | [#1] audio-beat-detection Cycles:10 Average:141.80 Median:143.50 stddev:20.70 (14.4%) stddev-sans-first:21.94 05:30:18 INFO - PID 4127 | Values: 144.0 124.0 143.0 182.0 120.0 144.0 143.0 126.0 170.0 122.0 05:30:18 INFO - PID 4127 | 05:30:18 INFO - PID 4127 | [#2] audio-dft Cycles:10 Average:165.30 Median:163.50 stddev:4.22 (2.6%) stddev-sans-first:4.47 05:30:18 INFO - PID 4127 | Values: 165.0 163.0 171.0 163.0 163.0 163.0 163.0 175.0 164.0 163.0 05:30:18 INFO - PID 4127 | 05:30:18 INFO - PID 4127 | [#3] audio-fft Cycles:10 Average:89.40 Median:77.50 stddev:28.19 (36.4%) stddev-sans-first:29.60 05:30:18 INFO - PID 4127 | Values: 78.0 76.0 77.0 166.0 75.0 74.0 74.0 92.0 99.0 83.0 05:30:18 INFO - PID 4127 | 05:30:18 INFO - PID 4127 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:81.00 stddev:24.55 (30.3%) stddev-sans-first:25.47 05:30:18 INFO - PID 4127 | Values: 82.0 81.0 138.0 81.0 82.0 82.0 129.0 81.0 81.0 129.0 05:30:18 INFO - PID 4127 | 05:30:18 INFO - PID 4127 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:1.16 (1.0%) stddev-sans-first:1.13 05:30:18 INFO - PID 4127 | Values: 113.0 115.0 115.0 114.0 114.0 113.0 114.0 117.0 114.0 114.0 05:30:18 INFO - PID 4127 | 05:30:18 INFO - PID 4127 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:151.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 05:30:18 INFO - PID 4127 | Values: 151.0 150.0 151.0 150.0 151.0 151.0 149.0 151.0 152.0 151.0 05:30:18 INFO - PID 4127 | 05:30:18 INFO - PID 4127 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:1.32 (1.4%) stddev-sans-first:1.36 05:30:18 INFO - PID 4127 | Values: 94.0 94.0 93.0 94.0 95.0 97.0 95.0 95.0 94.0 97.0 05:30:18 INFO - PID 4127 | 05:30:18 INFO - PID 4127 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.00 stddev:2.35 (4.3%) stddev-sans-first:2.47 05:30:18 INFO - PID 4127 | Values: 54.0 55.0 53.0 54.0 53.0 56.0 54.0 61.0 54.0 54.0 05:30:18 INFO - PID 4127 | 05:30:18 INFO - PID 4127 | [#9] json-stringify-tinderbox Cycles:10 Average:54.40 Median:54.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 05:30:18 INFO - PID 4127 | Values: 54.0 54.0 54.0 55.0 55.0 54.0 55.0 54.0 55.0 54.0 05:30:18 INFO - PID 4127 | 05:30:18 INFO - PID 4127 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.50 stddev:5.08 (6.2%) stddev-sans-first:5.14 05:30:18 INFO - PID 4127 | Values: 78.0 78.0 88.0 79.0 86.0 87.0 78.0 79.0 91.0 79.0 05:30:18 INFO - PID 4127 | 05:30:18 INFO - PID 4127 | [#11] stanford-crypto-ccm Cycles:10 Average:138.90 Median:136.00 stddev:18.19 (13.4%) stddev-sans-first:19.28 05:30:18 INFO - PID 4127 | Values: 137.0 153.0 135.0 143.0 128.0 124.0 126.0 126.0 133.0 184.0 05:30:18 INFO - PID 4127 | 05:30:18 INFO - PID 4127 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.40 Median:180.50 stddev:5.40 (3.0%) stddev-sans-first:5.49 05:30:18 INFO - PID 4127 | Values: 177.0 177.0 192.0 182.0 182.0 190.0 177.0 179.0 179.0 179.0 05:30:18 INFO - PID 4127 | 05:30:18 INFO - PID 4127 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.50 stddev:1.84 (2.6%) stddev-sans-first:1.86 05:30:18 INFO - PID 4127 | Values: 71.0 71.0 67.0 73.0 68.0 69.0 68.0 70.0 68.0 69.0 05:30:18 INFO - PID 4127 | -------- Summary: end -------- 05:30:18 INFO - PID 4127 | 05:30:19 INFO - PID 4127 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 05:30:19 INFO - TEST-INFO | 4127: exit 0 05:30:19 INFO - TEST-OK | kraken | took 62004ms 05:30:19 INFO - SUITE-END | took 1175s 05:30:19 INFO - Completed test suite (00:19:36) 05:30:19 INFO - javascript benchmark 05:30:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8494.904303454605, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3054.236440889777, 3074.1853408846646, 3090.0111964171465, 3111.7977331473467, 3131.6868313168684, 5948.672822994734, 6055.243094613179, 6104.5116390688745, 6142.570020098595, 6157.846053848651, 6015.639061656304, 6037.39626037396, 6055.0311950088, 6059.787907423241, 6074.271087469509, 5482.205080263359, 5525.668459892409, 5571.052921003419, 5603.8599035024245, 5604.523615492668, 5341.919871201935, 5542.362628297757, 5558.277423934903, 5602.523785478239, 5644.068728659787, 5461.808836690717, 5517.503424691797, 5546.722663866791, 5613.410591887875, 5613.578981576398, 5531.308586426697, 5541.612087153901, 5605.57958153136, 5622.437756224344, 5636.436356364372, 5410.404855465896, 5424.864378390533, 5471.179323101566, 5488.286522752017, 5570.359408668014, 5951.89889870371, 5969.104634304846, 5978.3124940631515, 6008.579399442041, 6050.27396712393, 6394.584352017104, 6402.847487452257, 6481.287058423617, 6494.577852439576, 6497.18785151856, 6436.3241859605005, 6479.902801457982, 6496.707648155844, 6550.0, 6561.80314590563, 6018.909716354258, 6089.939100609025, 6102.0541816018585, 6114.663693496856, 6134.049222370495, 6661.733530658817, 6677.332266773381, 6726.327367263235, 6759.188897332253, 6769.492288078413, 6300.527460440485, 6324.114623952651, 6379.425851673372, 6405.167328247391, 6408.974564069819, 6395.0, 6481.449076828522, 6482.902756458657, 6485.54601177913, 6490.156279683611, 6339.0, 6376.362363763679, 6434.7104380303, 6440.420362167428, 6472.9029064564065, 6340.651264180515, 6434.967825160844, 6454.2577603575255, 6495.382938620824, 6549.803505894831, 5251.553617942442, 5295.152775555893, 5329.493698098752, 5334.14653655421, 5337.0, 4531.3882625845745, 4550.061053079131, 4578.839740609063, 4581.541845815392, 4606.147862645421, 5554.805581804618, 5637.548996080303, 5652.349979752381, 5669.546436285087, 5675.858103547444, 6488.383603557749, 6545.280019197884, 6548.27968923418, 6557.2131344239, 6577.83555411109, 5600.887982240414, 5677.489025987681, 5682.346530149003, 5683.090705487102, 5689.687067211343, 5675.687837168995, 5681.147827825859, 5747.25285712863, 5749.338826034976, 5767.942320576824, 6120.112583675342, 6223.159873417121, 6231.096491008779, 6241.375862413813, 6347.873042539123, 6505.349465053457, 6525.184351956005, 6553.967230164009, 6590.439812615789, 6616.603003819786, 6274.090256912631, 6276.654783986742, 6298.433141017331, 6352.237731472253, 6359.332270111571, 6264.154339164154, 6357.459615932513, 6362.363763623601, 6370.26741924666, 6458.644774537445, 6474.449671777952, 6571.704273307808, 6587.505937054644, 6599.60402375859, 6600.900986485302, 6172.0, 6198.256209254738, 6272.874542509216, 6350.523710721622, 6352.714127864165, 6230.252369715663, 6259.123722678738, 6289.308176100534, 6298.779542715983, 6309.148264984168, 6275.215598050244, 6285.779997700059, 6287.308396076336, 6298.275698294755, 6312.905306420499, 6224.906626400698, 6317.210348706411, 6328.936710632835, 6353.3011368748475, 6424.421802037839, 6132.509399247961, 6162.969185154046, 6205.162303089025, 6207.131001659862, 6210.7515699371515], "value": 5925.516409425573, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [814.6334149632663, 852.4799872078031, 879.9252063574596, 884.7168905950094, 1169.1056341898443, 31342.216444588867, 31838.0, 41418.792906035465, 42290.0, 42324.78837605807, 43056.13887722244, 43338.34992475108, 43346.78326608363, 43515.12969740603, 43521.782391088, 7721.343685786715, 7817.5309481431295, 7883.881741773849, 7887.408444366667, 8042.195780421969, 7846.215378462137, 7905.841883162333, 7953.0, 7963.243491868263, 7968.800779980489, 7910.485818421813, 7947.562884041376, 7949.205079492062, 7962.442629015971, 7965.522068675869, 7853.332466740334, 7866.213378662117, 7907.0, 7923.445358824884, 7950.045994480671, 7749.806254843617, 7841.568713720743, 7841.686332546691, 7846.097698764658, 7850.057993040871, 39094.0, 39835.0, 39871.40192897109, 39877.40183897244, 39941.60058399408, 3570.6429357064344, 3613.8373773180006, 3614.8734794282072, 3623.3296840084404, 3623.5108260384773, 32201.51697724536, 32335.0, 32483.187920301945, 32491.0, 32534.6746532534, 4769.308450274691, 4926.802927882881, 4993.800247990076, 5029.622778291643, 5033.345665063518, 194802.0, 195064.99999999857, 195926.0, 195990.0, 196274.0, 49610.255846162334, 49660.0, 49704.75147624311, 49711.50288497141, 49934.0, 52629.2105618416, 52633.0, 52850.207246891325, 52946.470535294924, 52960.470395296325, 15393.923030385, 15650.608734781494, 15674.451394201149, 15680.294386752623, 15691.843081569266, 10936.671899843017, 11009.394483303335, 12543.372831358396, 12731.108822382344, 12744.808827867404, 15304.38782448712, 15362.385504579692, 15377.615559610875, 15456.459023934109, 15535.145566993699, 6087.817365479043, 6184.041473571604, 6212.099245609452, 6223.844403889939, 6245.781397651152, 988.8714467119229, 1006.9697909062739, 1012.6455740490769, 1025.7179275699093, 1027.5581499955092, 22965.425864353525, 29738.553921691193, 30382.0, 30474.085777426713, 30844.383112337626, 1080.783843231357, 1100.2133474565724, 1132.2413982631656, 1133.795916734979, 1149.804533229353, 12351.135420520477, 16069.196540172945, 16085.732087227414, 16204.055513338475, 16557.91721041387, 231504.0, 235644.0, 236627.0, 237187.0, 237299.0, 59543.70228148832, 60156.39843601508, 60175.39824601698, 60189.69905150534, 60243.0, 1501.2643804535699, 1535.0, 1535.3398038843181, 1543.1281326050746, 1551.2553974092498, 27523.724762752117, 27547.86226068857, 28504.57243141313, 28606.856965715036, 28639.570406444338, 53095.203571947226, 53170.73414632902, 53676.46323536871, 53706.0, 53754.73122634518, 208790.0, 210154.0, 211397.0, 211447.0, 211851.0, 37455.625443745215, 38680.6131938677, 39594.2081158381, 39959.40060899147, 40077.0, 47234.52765472301, 48756.756216218695, 49049.0, 49149.2627610579, 49265.50734492609, 33578.66421335755, 34570.65429345674, 34986.300273994886, 35601.1099722509, 35747.64252357443, 33897.66102338945, 34285.60066411819, 34923.65076349204, 35031.12422189466, 35038.0, 38689.80655096706, 38740.0, 38935.2212955745, 39144.217115658095, 39160.60839391684, 31435.528467072556, 32608.673913260565, 33575.496367554995, 33842.66157338494, 34014.149646259044, 23724.762752372255, 24340.391490212885, 24457.877710612043, 24491.63262551099, 25059.122930697336], "value": 18236.308309944856, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.3281927325756, 574.3194314737037, 579.2816907035277, 590.1059894260195, 595.2856572113463, 22340.77659223409, 22801.54396912061, 23306.41733956652, 23357.883210583943, 23370.88314558427, 25842.35394115148, 26569.0, 26589.335266618345, 26660.466790664173, 26731.86634066832, 6456.806295811121, 6617.371349721769, 6628.4034436900665, 6628.502862285348, 6648.0, 5990.49080828128, 6523.9673801630925, 6525.608463492182, 6547.57440766351, 6556.639384833832, 6473.061406096113, 6493.383128602799, 6500.349965003509, 6503.674816259192, 6516.5112616553715, 6483.935160648381, 6500.707468163921, 6513.576617519846, 6521.804345869631, 6530.183727034121, 6053.909191362133, 6058.666773327465, 6070.332263451061, 6073.544484163661, 6074.696265186723, 29225.415491690048, 29443.852780736175, 29821.10536683903, 31428.0, 31497.52753708696, 1895.4976931113265, 1940.2917934953641, 1940.4857712706144, 1941.175000624743, 1941.932032378874, 19114.426567202867, 19332.0, 19813.10841012158, 19814.70277945832, 20065.89637569933, 2329.7320808107115, 2369.597168481362, 2388.0, 2411.9879400602886, 2471.6910386201725, 140413.2979335097, 143331.56668433285, 143477.0, 143492.28253858665, 143859.28070359686, 13946.0, 14334.49829255992, 14779.856920746432, 15106.244687765568, 15180.848191517944, 23059.538809223723, 23198.65202021971, 23342.0, 23395.298141055795, 23468.64797028046, 9653.613855445703, 9697.951510242403, 9907.801843963225, 10000.649977250761, 10015.14871235953, 7805.2194780521495, 8221.17788221185, 9038.09619038091, 9098.727038188865, 9102.954485227532, 8192.18078192176, 9193.862092068624, 9303.162715355515, 9322.813543729088, 9376.5311734413, 2692.273086266697, 2747.6565429321336, 2793.706660800627, 2795.65054368204, 2825.39254060378, 942.2697409507687, 945.3571571331423, 948.9372098705106, 980.0983095552109, 990.4354517924858, 19480.220791168478, 19705.310314138937, 19755.40733777989, 19874.906880121733, 20480.897595511928, 1012.2812802910016, 1017.4556612212431, 1023.5956797065118, 1043.2540733375672, 1049.4070849969742, 10927.235093543375, 13093.869061309455, 13998.23009734454, 14105.647358816112, 14224.715505689828, 442882.0, 443977.0, 444009.0, 451146.0, 455775.0, 117938.0, 120050.0, 120419.0, 121326.39336803436, 121561.0, 1273.2042473454092, 1302.1796268351068, 1305.4125643460482, 1312.9934350328188, 1318.1432069155126, 20486.282980095624, 20939.37181884546, 21198.47003824855, 21721.13115475363, 22384.21655242059, 55028.72485637706, 55681.721591393405, 55695.44304556902, 56015.0, 57339.0, 65999.0, 66194.0, 66228.0, 66366.33633663795, 67105.0, 11926.940365298118, 12137.271763694207, 12670.493180273055, 14491.347889344794, 14803.0, 16779.496615101565, 17328.740068899227, 24255.51488970246, 24279.757202428456, 24586.13948511865, 18992.43022709321, 19068.0, 19162.13770380364, 19175.712364314266, 19409.514762130493, 15763.369465221263, 16414.507564773077, 17183.0, 17236.0, 17391.2173952175, 20037.59924801525, 20146.69779953331, 20415.08132134028, 20502.692459613416, 20504.487387815425, 14691.41234350614, 14853.85146148568, 14950.925245373703, 14968.0, 21701.240456583942, 19345.806541934402, 19869.0, 20010.499737506096, 20016.2994295199, 20021.29925452602], "value": 12103.768168134116, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1345.5088892554218, 1405.1639274631593, 1415.2923538230884, 1424.095699230988, 1428.7928250403693, 12889.0, 13480.325983700825, 13503.594892153227, 13550.864491355083, 13560.3897824598, 12909.096363254575, 13862.930685346559, 13939.0, 13997.230152341617, 14010.859891401084, 2512.5226207020655, 2556.18202175304, 2562.3209849389928, 2565.076572433922, 2568.6147077938367, 2533.037445770614, 2544.37662772621, 2604.335894346939, 2657.7209393013745, 2732.6037724529933, 2653.615225792259, 2673.037706425685, 2683.6108764229175, 2685.4494828560196, 2692.623032775413, 2257.548490301938, 2323.2217207235594, 2332.24202134307, 2338.8362814602983, 2338.97661023391, 2469.703635563726, 2498.0757119865766, 2529.2665127113114, 2534.569123249052, 2536.289838845108, 13335.333233338295, 13486.662833429244, 13533.39099740514, 13560.389782459715, 13812.792808107886, 7071.328223818729, 7276.781696549112, 7283.635818209122, 7376.815579610499, 7383.778486645409, 4591.403117594691, 4713.6464765142755, 4792.233242681189, 4866.416030076413, 4879.8780030499165, 1862.7392165096896, 1865.4776662534512, 1878.1736036144189, 1911.4074636862617, 1915.090332092259, 20800.47998800027, 20875.37373878786, 20924.79075209244, 20957.68563471549, 21037.68443473349, 5774.740136693859, 5983.970080149571, 6099.024156134997, 6143.662098584621, 6163.96918015416, 14928.70142597142, 14935.17856517902, 14940.252987350588, 14992.925035374754, 15016.699666006618, 7103.396211322096, 7233.782986510413, 7254.96372518134, 7261.7095316187815, 7265.2371500992695, 6278.811635650938, 6644.700988455531, 6655.0682904393425, 6669.299723529057, 6694.062831203635, 4472.798724057425, 4586.656000799953, 4636.142313671981, 4711.623070154379, 4712.5994290485005, 1196.2642974570576, 1237.2761934268374, 1258.1821815819608, 1316.4997301025548, 1364.3587513868465, 890.5636238243214, 921.8478950973015, 923.4920793563513, 932.9020452852488, 941.2893265584577, 7718.884216736754, 7789.0, 8005.159458256916, 8198.508089514648, 8290.792730181673, 938.9342746007713, 968.9273304502191, 1010.8786945566579, 1015.8171529124828, 1029.156092004564, 4133.8966525837095, 4970.15507363749, 5144.71704056273, 5184.351956005499, 5306.54894333986, 17932.731009034876, 18543.72184417235, 18620.0, 18632.534186645444, 18650.440486785417, 18023.909880450516, 18195.727064094048, 18198.909005454887, 18245.908770456062, 18298.908505457388, 9824.263180261509, 10460.058594726359, 10666.94666526678, 10682.51928663212, 10689.0, 7945.404094692805, 8296.83406331858, 8363.498190108612, 8437.198466145706, 8724.651013959625, 15825.366985320457, 16547.586310342336, 16675.999440033636, 16863.241154147847, 17059.061751603782, 16063.759043614122, 16201.59496012609, 16426.260818263447, 16669.49991500257, 16822.831771682126, 10753.301035432673, 11028.724281893017, 11038.0, 11047.447627618427, 11071.058959988492, 12512.562060327844, 12529.436175371948, 12663.240205587694, 12696.555620553236, 12778.169418987736, 9972.451515166735, 10472.319299245524, 10592.205584581341, 10662.413567253876, 10673.46632668348, 9727.0, 9758.121769040821, 10180.134688551556, 10217.642382516577, 10312.690619281433, 9123.589438475152, 9337.0, 9409.200217981548, 9426.057394260519, 9435.575399107194, 6833.692483838338, 6992.860142797217, 7037.120359955005, 7210.134783825974, 7245.166805817398, 6854.828629284308, 7318.926810731825, 7332.523385980107, 7396.55620662762, 7485.88771168422], "value": 6155.033772124808, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.2292945933804, 503.9218921067236, 520.5419231076652, 531.5534950641461, 533.759808086361, 6042.214512113419, 6068.180795592599, 6075.696215189239, 6165.414285642868, 6183.6598987055695, 5955.761769529214, 5967.49276311514, 5983.521318294537, 6011.639301641904, 6112.816615501531, 5092.541671249587, 5100.693958362492, 5117.667351622133, 5128.461511541291, 5161.251618515313, 4983.825566105187, 5076.949230507685, 5093.083245015914, 5119.0, 5156.767945442445, 5014.097462456756, 5045.722485263309, 5049.722265275427, 5076.720780357079, 5091.821786237482, 5039.445660977308, 5117.5650069744115, 5128.205128205097, 5162.0, 5168.612354073422, 4777.140114779339, 4799.66402351832, 4801.903961920742, 4810.903781924377, 4821.927671084936, 6007.4893634041155, 6010.2186715726675, 6030.6080104793045, 6039.184710064129, 6081.594307187989, 5853.64878107315, 5866.882662346729, 5869.882602347929, 5885.676287804169, 5914.319853216892, 6473.756257431495, 6500.609963402211, 6556.114924485181, 6580.506462015368, 6589.703463344161, 5228.660137091115, 5254.133068043769, 5291.206319052135, 5291.973540132313, 5307.548858347045, 6753.932460675429, 6755.324467553254, 6796.830079248009, 6811.182658081062, 6887.351038049297, 5330.760115794798, 5345.705986170798, 5372.328458942632, 5403.621746477787, 5436.0, 5461.9453805462235, 5498.780048798003, 5510.476504732044, 5516.475934786189, 5525.806596769094, 5795.971020144872, 5871.033203876664, 5898.380670029585, 5953.053238646898, 5978.0, 6193.752249910043, 6449.355064493607, 6490.221173459215, 6506.804795856132, 6522.5760325578685, 1806.1691621854095, 1858.0895361272878, 1911.8491696841054, 1922.2503223742751, 1930.5463216144194, 1398.7482253194523, 1407.8873690104767, 1412.8092707484564, 1422.7581311177125, 1464.6924145929474, 5487.341519017744, 5593.3847276799515, 5631.085430953495, 5689.914651280152, 5701.4013528579735, 6500.252470965805, 6506.642134682638, 6570.685862827454, 6577.967110164419, 6591.2862655708905, 5583.972080139573, 5591.741858081899, 5625.128105143709, 5664.631798933056, 5703.372629010805, 3448.2758620689433, 3531.8763843265874, 3549.982250088733, 3553.9289214216087, 3558.7153027757718, 6359.523035772336, 6463.515236357292, 6491.701659668085, 6514.73941042353, 6517.739290428424, 6772.390484856386, 6802.14973128359, 6803.489738269551, 6821.906855886428, 6839.931600684029, 6389.6805159741825, 6391.58454700443, 6405.711742971577, 6460.25707043696, 6478.352164783672, 6620.172478440195, 6646.501512386687, 6677.131972843499, 6686.364795344434, 6686.531942764154, 6526.608403495616, 6542.037388783251, 6549.8690026200165, 6552.63960482159, 6583.769568065286, 6425.518086143651, 6426.614403135827, 6457.160569125984, 6459.0, 6474.805755827333, 4923.064617722621, 4926.458089610212, 4937.5556199942175, 4949.208126699711, 4960.404751429852, 6318.368163183829, 6399.392057754506, 6525.510586706111, 6547.9672601636685, 6659.733610655713, 6268.561200715906, 6377.7767778127545, 6380.266269378895, 6385.968070159805, 6468.223813142453, 6276.650520138192, 6349.333320001518, 6400.487960963019, 6424.325445828307, 6428.357164283534, 6202.503799696104, 6308.400701933309, 6311.0, 6335.493160547053, 6369.649669268049, 6435.742570297323, 6477.611343319416, 6479.384458476437, 6526.379993900572, 6536.215654121345, 6196.380361963767, 6247.406496382836, 6278.46633036197, 6284.366064823087, 6306.369363063657], "value": 5101.657731113171, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [912.2838571721201, 916.2990312411007, 923.9353245272829, 933.3046880074346, 942.4486675294952, 15773.290201940912, 16821.41125060623, 16823.91588042058, 16840.410585629506, 18420.0, 20730.689039664416, 22052.8897355513, 22188.0, 22213.777862221414, 22306.665400019014, 1023.4064242739212, 1054.051353781599, 1061.1139698351885, 1061.7929503746773, 1061.8035663402295, 970.1511177719495, 1047.0576481166934, 1054.0618849224197, 1054.219877290807, 1054.9050585447308, 1063.5161001744189, 1103.0, 1111.111111111108, 1111.7053980695123, 1112.1325366214326, 1100.8954149355839, 1101.3557069114577, 1103.2828661370174, 1103.448275862069, 1104.7845670094375, 808.6644042722263, 808.8584497712877, 808.9878651820227, 809.1018968944467, 810.1331575214523, 16962.23669934856, 17390.826091739047, 17492.12539373026, 17600.0, 17615.295388184586, 20661.8966905166, 20866.686999695015, 21053.47366315839, 21248.25631102904, 21318.253861114943, 16012.959157654715, 16251.02493850361, 16538.007719536865, 16556.254968526446, 16559.668806623922, 3553.431450967833, 3604.062943634674, 3620.6379362063844, 3631.1466805300734, 3632.691221246197, 123761.0, 125413.0, 129533.0, 130730.3463482686, 132074.3396283022, 15498.0, 16106.355745770272, 16587.91706041486, 16674.333026678796, 16765.497035088967, 28597.285067873054, 30385.24036899051, 31312.06063818089, 31434.84282578618, 31528.684713153034, 8396.664133434717, 8547.829043419097, 8556.101609331055, 8561.52911589856, 8572.099929507436, 4181.874543763692, 4271.487421509377, 4285.271503844354, 4296.462942132233, 4297.82808687649, 5003.774830132653, 5187.610929180327, 5296.3379577552805, 5301.814436494781, 5308.230306605597, 919.3426699909596, 939.5020639061308, 943.7876477792441, 951.1107114847501, 951.6526467839188, 626.2985456288985, 639.7057353617388, 654.5974225851163, 663.8074958262147, 668.7258224128084, 11378.772424551462, 13323.866761332456, 13587.728245435233, 13622.795658065137, 13759.587212383645, 676.7462201674372, 693.0747452151334, 709.9112610923635, 717.3113810741746, 725.8802297620939, 5533.7786488540005, 5540.529055030287, 5828.475437210586, 5908.586398952032, 6344.016677415008, 93005.0, 93323.0667693328, 95865.52067239619, 98886.50556747314, 101885.49057254667, 90068.5496572526, 91166.54416728007, 92745.0, 92784.0, 94725.0, 74648.0, 76696.0, 77813.61093194498, 80416.19583804204, 82697.58651206705, 11824.40877956116, 12330.691732706755, 12742.235465872078, 12763.680907977376, 13085.738285234433, 35648.64351356453, 36405.27189456143, 36880.631193688794, 37858.43212351762, 37990.81004594959, 63968.0, 66136.6693166531, 66930.0, 67093.0, 68220.6588967052, 19412.126454309873, 19704.113314900576, 19709.507262317984, 19753.40739777809, 20092.799072009093, 20731.792682072984, 21592.35222943314, 21827.0, 21829.454263643536, 22146.77853221447, 18645.533861653566, 18658.06709664484, 18834.434966950466, 18914.810851891303, 19189.232430702614, 20168.49578760543, 20299.08654110539, 20472.385828425173, 20692.379228623166, 20907.1637134519, 19752.604947901247, 19941.302054428026, 20263.29078482246, 20462.693059604415, 20567.58864822725, 11605.76788464243, 12123.090768192596, 12167.634970950885, 12666.493340266286, 12775.80836287475, 14215.218163001135, 14228.217448040457, 14296.499622513162, 14353.641158970691, 14478.927605361905], "value": 9149.472750837269, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 106.0, 109.0, 112.0, 117.0, 109.0, 100.0, 110.0, 111.0], "value": 108.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 124.0, 143.0, 182.0, 120.0, 144.0, 143.0, 126.0, 170.0, 122.0], "value": 141.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 171.0, 163.0, 163.0, 163.0, 163.0, 175.0, 164.0, 163.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 77.0, 166.0, 75.0, 74.0, 74.0, 92.0, 99.0, 83.0], "value": 89.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 138.0, 81.0, 82.0, 82.0, 129.0, 81.0, 81.0, 129.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 115.0, 114.0, 114.0, 113.0, 114.0, 117.0, 114.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 151.0, 150.0, 151.0, 151.0, 149.0, 151.0, 152.0, 151.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 94.0, 95.0, 97.0, 95.0, 95.0, 94.0, 97.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 53.0, 54.0, 53.0, 56.0, 54.0, 61.0, 54.0, 54.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 55.0, 55.0, 54.0, 55.0, 54.0, 55.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 88.0, 79.0, 86.0, 87.0, 78.0, 79.0, 91.0, 79.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 153.0, 135.0, 143.0, 128.0, 124.0, 126.0, 126.0, 133.0, 184.0], "value": 138.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 177.0, 192.0, 182.0, 182.0, 190.0, 177.0, 179.0, 179.0, 179.0], "value": 181.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 67.0, 73.0, 68.0, 69.0, 68.0, 70.0, 68.0, 69.0], "value": 69.4, "unit": "score"}]}]} 05:30:19 INFO - Return code: 0 05:30:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:30:20 INFO - # TBPL SUCCESS # 05:30:20 INFO - Running post-action listener: _package_coverage_data 05:30:20 INFO - Running post-action listener: _resource_record_post_action 05:30:20 INFO - [mozharness: 2017-07-20 12:30:20.001703Z] Finished run-tests step (success) 05:30:20 INFO - Running post-run listener: _resource_record_post_run 05:30:20 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 5177344; Write bytes: 445894656; Read time: 1868; Write time: 314952 05:30:20 INFO - TinderboxPrint: CPU usage
13.1% 05:30:20 INFO - TinderboxPrint: I/O read bytes / time
5,177,344 / 1,868 05:30:20 INFO - TinderboxPrint: I/O write bytes / time
445,894,656 / 314,952 05:30:20 INFO - TinderboxPrint: CPU idle
8,267.1 (86.8%) 05:30:20 INFO - TinderboxPrint: CPU user
1,201.0 (12.6%) 05:30:20 INFO - TinderboxPrint: Swap in / out
0 / 0 05:30:20 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 115216384; Read time: 52; Write time: 100224 05:30:20 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:30:20 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 2805760; Write bytes: 330256384; Read time: 1636; Write time: 214708 05:30:20 INFO - Running post-run listener: _upload_blobber_files 05:30:20 INFO - Blob upload gear active. 05:30:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:30:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:30:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:30:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:30:21 INFO - (blobuploader) - INFO - Open directory for files ... 05:30:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:30:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:30:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:30:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:30:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:30:29 INFO - (blobuploader) - INFO - Done attempting. 05:30:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:30:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:30:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:30:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:30:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:30:30 INFO - (blobuploader) - INFO - Done attempting. 05:30:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:30:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:30:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:30:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:30:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:30:31 INFO - (blobuploader) - INFO - Done attempting. 05:30:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:30:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:30:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:30:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:30:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:30:32 INFO - (blobuploader) - INFO - Done attempting. 05:30:32 INFO - (blobuploader) - INFO - Iteration through files over. 05:30:32 INFO - Return code: 0 05:30:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:30:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:30:32 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7f390a08ea14d4af3b52490b3a6d6b8ec3dabb1ecb0650308b94c7c7aa03e10a1bd050feb84f99e07ac8d9c862978380a8c0ef7d1a5eae8a55234ffc70f28642", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4ad42b24daec92a2d06eb58b89a8854a5eb20e3bb8bcc893f307f740251189d07069480eeebb4570b44fa6061b5cdb3d046708c6ee3aa96842c6148f1696ee5d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a30601f49cb9bee964887d4158b58538147a026398d78b2410cc0a9648e396dcfc401285138af031d8499635557f8561d6aac11ed4213cd2f116d97589bb8d46", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cf005f33fd95f4f7fdcab566b201822316cf94f9b5373aec1427247a5a67b9797db0e1f4607faf454e9d4b3757fcc80697f6503b1117db3f9788f6e053c0ea86"} 05:30:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:30:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:30:32 INFO - Contents: 05:30:32 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7f390a08ea14d4af3b52490b3a6d6b8ec3dabb1ecb0650308b94c7c7aa03e10a1bd050feb84f99e07ac8d9c862978380a8c0ef7d1a5eae8a55234ffc70f28642", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4ad42b24daec92a2d06eb58b89a8854a5eb20e3bb8bcc893f307f740251189d07069480eeebb4570b44fa6061b5cdb3d046708c6ee3aa96842c6148f1696ee5d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a30601f49cb9bee964887d4158b58538147a026398d78b2410cc0a9648e396dcfc401285138af031d8499635557f8561d6aac11ed4213cd2f116d97589bb8d46", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cf005f33fd95f4f7fdcab566b201822316cf94f9b5373aec1427247a5a67b9797db0e1f4607faf454e9d4b3757fcc80697f6503b1117db3f9788f6e053c0ea86"} 05:30:32 INFO - Running post-run listener: copy_logs_to_upload_dir 05:30:32 INFO - Copying logs to upload dir... 05:30:32 INFO - mkdir: /builds/slave/test/build/upload/logs 05:30:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.203823 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-07-20 05:30:32.145071) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-20 05:30:32.149261) ========= 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=438111f3d31ce799eff2119d000001bc-1500545008.302335-83748825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7f390a08ea14d4af3b52490b3a6d6b8ec3dabb1ecb0650308b94c7c7aa03e10a1bd050feb84f99e07ac8d9c862978380a8c0ef7d1a5eae8a55234ffc70f28642", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4ad42b24daec92a2d06eb58b89a8854a5eb20e3bb8bcc893f307f740251189d07069480eeebb4570b44fa6061b5cdb3d046708c6ee3aa96842c6148f1696ee5d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a30601f49cb9bee964887d4158b58538147a026398d78b2410cc0a9648e396dcfc401285138af031d8499635557f8561d6aac11ed4213cd2f116d97589bb8d46", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cf005f33fd95f4f7fdcab566b201822316cf94f9b5373aec1427247a5a67b9797db0e1f4607faf454e9d4b3757fcc80697f6503b1117db3f9788f6e053c0ea86"} build_url:https://queue.taskcluster.net/v1/task/YDBNoQM-Ta2UROCREiJdZw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011152 build_url: 'https://queue.taskcluster.net/v1/task/YDBNoQM-Ta2UROCREiJdZw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7f390a08ea14d4af3b52490b3a6d6b8ec3dabb1ecb0650308b94c7c7aa03e10a1bd050feb84f99e07ac8d9c862978380a8c0ef7d1a5eae8a55234ffc70f28642", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4ad42b24daec92a2d06eb58b89a8854a5eb20e3bb8bcc893f307f740251189d07069480eeebb4570b44fa6061b5cdb3d046708c6ee3aa96842c6148f1696ee5d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a30601f49cb9bee964887d4158b58538147a026398d78b2410cc0a9648e396dcfc401285138af031d8499635557f8561d6aac11ed4213cd2f116d97589bb8d46", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cf005f33fd95f4f7fdcab566b201822316cf94f9b5373aec1427247a5a67b9797db0e1f4607faf454e9d4b3757fcc80697f6503b1117db3f9788f6e053c0ea86"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-20 05:30:32.174788) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-20 05:30:32.175147) ========= 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=438111f3d31ce799eff2119d000001bc-1500545008.302335-83748825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004409 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-20 05:30:32.260010) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-20 05:30:32.260329) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-20 05:30:32.260726) ========= ========= Total master_lag: 0.21 =========