builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-006 starttime: 1498479395.34 results: success (0) revision: af9a8cebd43fb23822be25c5d4d065d5e9e195b8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-26 05:16:35.340509) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-26 05:16:35.340958) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-26 05:16:35.341252) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-26 05:16:35.356404) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-26 05:16:35.356693) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1498479395.904927-1339089345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-26 05:16:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2017-06-26 05:16:36 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.085803 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-26 05:16:35.454834) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-26 05:16:35.455152) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1498479395.904927-1339089345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013756 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-26 05:16:35.507188) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-06-26 05:16:35.507509) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev af9a8cebd43fb23822be25c5d4d065d5e9e195b8 --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 af9a8cebd43fb23822be25c5d4d065d5e9e195b8 --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=e31afd3c0f0de4e86ebe4d94000001b5-1498479395.904927-1339089345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-26 05:16:36,641 truncating revision to first 12 chars 2017-06-26 05:16:36,641 Setting DEBUG logging. 2017-06-26 05:16:36,641 attempt 1/10 2017-06-26 05:16:36,641 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/af9a8cebd43f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-26 05:16:38,339 unpacking tar archive at: mozilla-central-af9a8cebd43f/testing/mozharness/ program finished with exit code 0 elapsedTime=2.391409 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-06-26 05:16:37.913997) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-26 05:16:37.914319) ========= script_repo_revision: af9a8cebd43fb23822be25c5d4d065d5e9e195b8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-26 05:16:37.914710) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-26 05:16:37.914977) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-26 05:16:37.926352) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-06-26 05:16:37.926634) ========= /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=e31afd3c0f0de4e86ebe4d94000001b5-1498479395.904927-1339089345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:16:39 INFO - MultiFileLogger online at 20170626 05:16:39 in /builds/slave/test 05:16:39 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:16:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:16:39 INFO - {'append_to_log': False, 05:16:39 INFO - 'base_work_dir': '/builds/slave/test', 05:16:39 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:16:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:16:39 INFO - 'branch': 'Firefox-Non-PGO', 05:16:39 INFO - 'buildbot_json_path': 'buildprops.json', 05:16:39 INFO - 'config_files': ('talos/linux_config.py',), 05:16:39 INFO - 'default_actions': ('clobber', 05:16:39 INFO - 'read-buildbot-config', 05:16:39 INFO - 'download-and-extract', 05:16:39 INFO - 'populate-webroot', 05:16:39 INFO - 'create-virtualenv', 05:16:39 INFO - 'install', 05:16:39 INFO - 'setup-mitmproxy', 05:16:39 INFO - 'run-tests'), 05:16:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:16:39 INFO - 'download_minidump_stackwalk': True, 05:16:39 INFO - 'download_symbols': 'ondemand', 05:16:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:16:39 INFO - 'tooltool.py': '/tools/tooltool.py', 05:16:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:16:39 INFO - '/tools/misc-python/virtualenv.py')}, 05:16:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:16:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:16:39 INFO - 'gecko_profile': False, 05:16:39 INFO - 'gecko_profile_interval': 0, 05:16:39 INFO - 'installer_path': 'installer.exe', 05:16:39 INFO - 'log_level': 'info', 05:16:39 INFO - 'log_name': 'talos', 05:16:39 INFO - 'log_to_console': True, 05:16:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:16:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:16:39 INFO - 'opt_config_files': (), 05:16:39 INFO - 'pip_index': False, 05:16:39 INFO - 'suite': 'dromaeojs-e10s', 05:16:39 INFO - 'system_bits': '32', 05:16:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:16:39 INFO - 'title': 'talos-linux64-ix-006', 05:16:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:16:39 INFO - 'use_talos_json': True, 05:16:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:16:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:16:39 INFO - 'work_dir': 'build'} 05:16:39 INFO - [mozharness: 2017-06-26 12:16:39.156914Z] Running clobber step. 05:16:39 INFO - Running pre-action listener: _resource_record_pre_action 05:16:39 INFO - Running main action method: clobber 05:16:39 INFO - rmtree: /builds/slave/test/build 05:16:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:16:40 INFO - Running post-action listener: _resource_record_post_action 05:16:40 INFO - [mozharness: 2017-06-26 12:16:40.789902Z] Finished clobber step (success) 05:16:40 INFO - [mozharness: 2017-06-26 12:16:40.790000Z] Running read-buildbot-config step. 05:16:40 INFO - Running pre-action listener: _resource_record_pre_action 05:16:40 INFO - Running main action method: read_buildbot_config 05:16:40 INFO - Using buildbot properties: 05:16:40 INFO - { 05:16:40 INFO - "project": "", 05:16:40 INFO - "product": "firefox", 05:16:40 INFO - "who": "cbook@mozilla.com", 05:16:40 INFO - "installer_path": "public/build/target.tar.bz2", 05:16:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:16:40 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:16:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 05:16:40 INFO - "stage_platform": "linux64", 05:16:40 INFO - "basedir": "/builds/slave/test", 05:16:40 INFO - "buildnumber": 938, 05:16:40 INFO - "platform": "ubuntu64_hw", 05:16:40 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:16:40 INFO - "slavebuilddir": "test", 05:16:40 INFO - "taskId": "UhFj9LW9TnKyTNrqL12TRA", 05:16:40 INFO - "branch": "mozilla-central", 05:16:40 INFO - "script_repo_revision": "production", 05:16:40 INFO - "revision": "af9a8cebd43fb23822be25c5d4d065d5e9e195b8", 05:16:40 INFO - "slavename": "talos-linux64-ix-006", 05:16:40 INFO - "repo_path": "mozilla-central" 05:16:40 INFO - } 05:16:40 INFO - Finding installer, test and symbols from parent task. 05:16:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UhFj9LW9TnKyTNrqL12TRA'}, attempt #1 05:16:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UhFj9LW9TnKyTNrqL12TRA'}, attempt #1 05:16:41 INFO - Task dependencies: VWKTNCDOTqGeauhoZVS7QQ 05:16:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VWKTNCDOTqGeauhoZVS7QQ'}, attempt #1 05:16:42 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/VWKTNCDOTqGeauhoZVS7QQ/artifacts/public/build/target.tar.bz2 05:16:42 INFO - Set test_url: https://queue.taskcluster.net/v1/task/VWKTNCDOTqGeauhoZVS7QQ/artifacts/public/build/test_packages.json 05:16:42 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/VWKTNCDOTqGeauhoZVS7QQ/artifacts/public/build/target.crashreporter-symbols.zip 05:16:42 INFO - Running post-action listener: _resource_record_post_action 05:16:42 INFO - [mozharness: 2017-06-26 12:16:42.150170Z] Finished read-buildbot-config step (success) 05:16:42 INFO - [mozharness: 2017-06-26 12:16:42.150386Z] Running download-and-extract step. 05:16:42 INFO - Running pre-action listener: _resource_record_pre_action 05:16:42 INFO - Running main action method: download_and_extract 05:16:42 INFO - mkdir: /builds/slave/test/build/tests 05:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:42 INFO - trying https://queue.taskcluster.net/v1/task/VWKTNCDOTqGeauhoZVS7QQ/artifacts/public/build/target.test_packages.json 05:16:42 INFO - Downloading https://queue.taskcluster.net/v1/task/VWKTNCDOTqGeauhoZVS7QQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:16:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VWKTNCDOTqGeauhoZVS7QQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:16:42 INFO - Downloaded 989 bytes. 05:16:42 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:16:42 INFO - Using the following test package requirements: 05:16:42 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:16:42 INFO - u'common': [u'target.common.tests.zip'], 05:16:42 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:16:42 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:16:42 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:16:42 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:16:42 INFO - u'mozbase': [u'target.common.tests.zip'], 05:16:42 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:16:42 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:16:42 INFO - u'web-platform': [u'target.common.tests.zip', 05:16:42 INFO - u'target.web-platform.tests.tar.gz'], 05:16:42 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:16:42 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:16:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VWKTNCDOTqGeauhoZVS7QQ/artifacts/public/build/target.common.tests.zip 05:16:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VWKTNCDOTqGeauhoZVS7QQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:16:42 INFO - Fetch https://queue.taskcluster.net/v1/task/VWKTNCDOTqGeauhoZVS7QQ/artifacts/public/build/target.common.tests.zip into memory 05:16:43 INFO - Content-Length response header: 67757554 05:16:43 INFO - Bytes received: 67757554 05:16:54 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:16:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VWKTNCDOTqGeauhoZVS7QQ/artifacts/public/build/target.common.tests.zip 05:16:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VWKTNCDOTqGeauhoZVS7QQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:16:54 INFO - Fetch https://queue.taskcluster.net/v1/task/VWKTNCDOTqGeauhoZVS7QQ/artifacts/public/build/target.common.tests.zip into memory 05:16:56 INFO - Content-Length response header: 67757554 05:16:56 INFO - Bytes received: 67757554 05:17:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VWKTNCDOTqGeauhoZVS7QQ/artifacts/public/build/target.talos.tests.zip 05:17:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VWKTNCDOTqGeauhoZVS7QQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:17:08 INFO - Fetch https://queue.taskcluster.net/v1/task/VWKTNCDOTqGeauhoZVS7QQ/artifacts/public/build/target.talos.tests.zip into memory 05:17:08 INFO - Content-Length response header: 14441319 05:17:08 INFO - Bytes received: 14441319 05:17: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:17:09 INFO - trying https://queue.taskcluster.net/v1/task/VWKTNCDOTqGeauhoZVS7QQ/artifacts/public/build/target.tar.bz2 05:17:09 INFO - Downloading https://queue.taskcluster.net/v1/task/VWKTNCDOTqGeauhoZVS7QQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:17:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VWKTNCDOTqGeauhoZVS7QQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:17:10 INFO - Downloaded 61629832 bytes. 05:17:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VWKTNCDOTqGeauhoZVS7QQ/artifacts/public/build/target.tar.bz2 05:17:10 INFO - mkdir: /builds/slave/test/properties 05:17:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:17:10 INFO - Writing to file /builds/slave/test/properties/build_url 05:17:10 INFO - Contents: 05:17:10 INFO - build_url:https://queue.taskcluster.net/v1/task/VWKTNCDOTqGeauhoZVS7QQ/artifacts/public/build/target.tar.bz2 05:17:10 INFO - Running post-action listener: _resource_record_post_action 05:17:10 INFO - Running post-action listener: set_extra_try_arguments 05:17:10 INFO - [mozharness: 2017-06-26 12:17:10.208593Z] Finished download-and-extract step (success) 05:17:10 INFO - [mozharness: 2017-06-26 12:17:10.208689Z] Running populate-webroot step. 05:17:10 INFO - Running pre-action listener: _resource_record_pre_action 05:17:10 INFO - Running main action method: populate_webroot 05:17:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:17:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:17:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:17:10 INFO - '--tppagecycles', 05:17:10 INFO - '7'], 05:17:10 INFO - 'tests': ['tsvgm']}}, 05:17:10 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:17:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:17:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:17:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:17:10 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:17:10 INFO - 'talos_options': ['--disable-e10s'], 05:17:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:17:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:17:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:17:10 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:17:10 INFO - 'talos_options': ['--disable-e10s'], 05:17:10 INFO - 'tests': ['damp', 'tps']}, 05:17:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:17:10 INFO - 'tests': ['damp', 'tps']}, 05:17:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:17:10 INFO - 'tests': ['dromaeo_dom']}, 05:17:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:17:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:17:10 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:17:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:17:10 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:17:10 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:17:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:17:10 INFO - 'tests': ['a11yr', 05:17:10 INFO - 'ts_paint', 05:17:10 INFO - 'tpaint', 05:17:10 INFO - 'sessionrestore', 05:17:10 INFO - 'sessionrestore_no_auto_restore', 05:17:10 INFO - 'tabpaint']}, 05:17:10 INFO - 'other-e10s': {'tests': ['a11yr', 05:17:10 INFO - 'ts_paint', 05:17:10 INFO - 'tpaint', 05:17:10 INFO - 'sessionrestore', 05:17:10 INFO - 'sessionrestore_no_auto_restore', 05:17:10 INFO - 'tabpaint']}, 05:17:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:17:10 INFO - 'ts_paint', 05:17:10 INFO - 'tpaint', 05:17:10 INFO - 'sessionrestore', 05:17:10 INFO - 'sessionrestore_no_auto_restore', 05:17:10 INFO - 'tabpaint']}, 05:17:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:17:10 INFO - 'ts_paint', 05:17:10 INFO - 'tpaint', 05:17:10 INFO - 'sessionrestore', 05:17:10 INFO - 'sessionrestore_no_auto_restore', 05:17:10 INFO - 'tabpaint']}, 05:17:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:17:10 INFO - 'tests': ['a11yr', 05:17:10 INFO - 'ts_paint', 05:17:10 INFO - 'tpaint', 05:17:10 INFO - 'sessionrestore', 05:17:10 INFO - 'sessionrestore_no_auto_restore', 05:17:10 INFO - 'tabpaint']}, 05:17:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:17:10 INFO - 'tests': ['a11yr', 05:17:10 INFO - 'ts_paint', 05:17:10 INFO - 'tpaint', 05:17:10 INFO - 'sessionrestore', 05:17:10 INFO - 'sessionrestore_no_auto_restore', 05:17:10 INFO - 'tabpaint']}, 05:17:10 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 05:17:10 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 05:17:10 INFO - 'bloom_basic_ref']}, 05:17:10 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:17:10 INFO - 'talos_options': ['--mitmproxy', 05:17:10 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:17:10 INFO - '--firstNonBlankPaint'], 05:17:10 INFO - 'tests': ['quantum_pageload_google', 05:17:10 INFO - 'quantum_pageload_youtube', 05:17:10 INFO - 'quantum_pageload_amazon', 05:17:10 INFO - 'quantum_pageload_facebook']}, 05:17:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:17:10 INFO - 'tests': ['tsvgx', 05:17:10 INFO - 'tsvgr_opacity', 05:17:10 INFO - 'tart', 05:17:10 INFO - 'tscrollx', 05:17:10 INFO - 'cart', 05:17:10 INFO - 'tsvg_static']}, 05:17:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:17:10 INFO - 'tsvgr_opacity', 05:17:10 INFO - 'tart', 05:17:10 INFO - 'tscrollx', 05:17:10 INFO - 'cart', 05:17:10 INFO - 'tsvg_static']}, 05:17:10 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:17:10 INFO - 'talos_options': ['--disable-e10s'], 05:17:10 INFO - 'tests': ['tp5o']}, 05:17:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:17:10 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:17:10 INFO - 'talos_options': ['--disable-e10s', 05:17:10 INFO - '--xperf_path', 05:17:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:17:10 INFO - 'tests': ['tp5n']}, 05:17:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:17:10 INFO - 'talos_options': ['--xperf_path', 05:17:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:17:10 INFO - 'tests': ['tp5n']}}, 05:17:10 INFO - 'talos.zip': {'path': '', 05:17:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:17:10 INFO - Running post-action listener: _resource_record_post_action 05:17:10 INFO - [mozharness: 2017-06-26 12:17:10.223493Z] Finished populate-webroot step (success) 05:17:10 INFO - [mozharness: 2017-06-26 12:17:10.223582Z] Running create-virtualenv step. 05:17:10 INFO - Running pre-action listener: _resource_record_pre_action 05:17:10 INFO - Running main action method: create_virtualenv 05:17:10 INFO - Creating virtualenv /builds/slave/test/build/venv 05:17:10 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:17:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:17:10 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:17:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:17:10 INFO - Using real prefix '/usr' 05:17:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:17:10 INFO - Installing distribute.............................................................................................................................................................................................done. 05:17:12 INFO - Installing pip.................done. 05:17:12 INFO - Return code: 0 05:17:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:17:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:17:13 INFO - Reading from file tmpfile_stdout 05:17:13 INFO - Output received: 05:17:13 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:17:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:17: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:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17: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:17:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc573b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe31a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd59a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd3140>, '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 0xfd3a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd3ed0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1498479395.904927-1339089345', '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:17: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', 'pip>=1.5'] in /builds/slave/test/build 05:17: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 pip>=1.5 05:17:13 INFO - Using env: {'DISPLAY': ':0', 05:17:13 INFO - 'HOME': '/home/cltbld', 05:17:13 INFO - 'LANG': 'en_US.UTF-8', 05:17:13 INFO - 'LANGUAGE': 'en_US:en', 05:17:13 INFO - 'LOGNAME': 'cltbld', 05:17:13 INFO - 'MAIL': '/var/mail/cltbld', 05:17:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:13 INFO - 'MOZ_NO_REMOTE': '1', 05:17:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:13 INFO - 'NO_EM_RESTART': '1', 05:17:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:13 INFO - 'PWD': '/builds/slave/test', 05:17:13 INFO - 'SHELL': '/bin/bash', 05:17:13 INFO - 'SHLVL': '1', 05:17:13 INFO - 'TERM': 'linux', 05:17:13 INFO - 'TMOUT': '86400', 05:17:13 INFO - 'USER': 'cltbld', 05:17:13 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1498479395.904927-1339089345', 05:17:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:13 INFO - '_': '/tools/buildbot/bin/python'} 05:17:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:13 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:17:13 INFO - Cleaning up... 05:17:13 INFO - Return code: 0 05:17:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:17: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:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17: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:17:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17: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', '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 0xc573b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe31a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd59a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd3140>, '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 0xfd3a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd3ed0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1498479395.904927-1339089345', '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:17: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', 'psutil>=3.1.1'] in /builds/slave/test/build 05:17: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 psutil>=3.1.1 05:17:13 INFO - Using env: {'DISPLAY': ':0', 05:17:13 INFO - 'HOME': '/home/cltbld', 05:17:13 INFO - 'LANG': 'en_US.UTF-8', 05:17:13 INFO - 'LANGUAGE': 'en_US:en', 05:17:13 INFO - 'LOGNAME': 'cltbld', 05:17:13 INFO - 'MAIL': '/var/mail/cltbld', 05:17:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:13 INFO - 'MOZ_NO_REMOTE': '1', 05:17:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:13 INFO - 'NO_EM_RESTART': '1', 05:17:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:13 INFO - 'PWD': '/builds/slave/test', 05:17:13 INFO - 'SHELL': '/bin/bash', 05:17:13 INFO - 'SHLVL': '1', 05:17:13 INFO - 'TERM': 'linux', 05:17:13 INFO - 'TMOUT': '86400', 05:17:13 INFO - 'USER': 'cltbld', 05:17:13 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1498479395.904927-1339089345', 05:17:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:13 INFO - '_': '/tools/buildbot/bin/python'} 05:17:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:13 INFO - Downloading/unpacking psutil>=3.1.1 05:17: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:17: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:17: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:17: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:17:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:17:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:17:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:17:14 INFO - Installing collected packages: psutil 05:17:14 INFO - Running setup.py install for psutil 05:17:14 INFO - building 'psutil._psutil_linux' extension 05:17:14 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:17:14 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:17:14 INFO - building 'psutil._psutil_posix' extension 05:17:14 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:17:15 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:17:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:17:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:17:15 INFO - Successfully installed psutil 05:17:15 INFO - Cleaning up... 05:17:15 INFO - Return code: 0 05:17:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:17: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:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17: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:17:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:15 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 0xc573b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe31a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd59a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd3140>, '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 0xfd3a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd3ed0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1498479395.904927-1339089345', '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:17:15 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:17:15 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:17:15 INFO - Using env: {'DISPLAY': ':0', 05:17:15 INFO - 'HOME': '/home/cltbld', 05:17:15 INFO - 'LANG': 'en_US.UTF-8', 05:17:15 INFO - 'LANGUAGE': 'en_US:en', 05:17:15 INFO - 'LOGNAME': 'cltbld', 05:17:15 INFO - 'MAIL': '/var/mail/cltbld', 05:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:15 INFO - 'MOZ_NO_REMOTE': '1', 05:17:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:15 INFO - 'NO_EM_RESTART': '1', 05:17:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:15 INFO - 'PWD': '/builds/slave/test', 05:17:15 INFO - 'SHELL': '/bin/bash', 05:17:15 INFO - 'SHLVL': '1', 05:17:15 INFO - 'TERM': 'linux', 05:17:15 INFO - 'TMOUT': '86400', 05:17:15 INFO - 'USER': 'cltbld', 05:17:15 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1498479395.904927-1339089345', 05:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:15 INFO - '_': '/tools/buildbot/bin/python'} 05:17:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:17:15 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:17:15 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:17:15 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:17:15 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:17:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:17:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:17:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:17:16 INFO - Installing collected packages: mozsystemmonitor 05:17:16 INFO - Running setup.py install for mozsystemmonitor 05:17:16 INFO - Successfully installed mozsystemmonitor 05:17:16 INFO - Cleaning up... 05:17:16 INFO - Return code: 0 05:17:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:17:16 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:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:16 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:17:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:16 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 0xc573b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe31a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd59a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd3140>, '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 0xfd3a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd3ed0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1498479395.904927-1339089345', '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:17:16 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:17:16 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:17:16 INFO - Using env: {'DISPLAY': ':0', 05:17:16 INFO - 'HOME': '/home/cltbld', 05:17:16 INFO - 'LANG': 'en_US.UTF-8', 05:17:16 INFO - 'LANGUAGE': 'en_US:en', 05:17:16 INFO - 'LOGNAME': 'cltbld', 05:17:16 INFO - 'MAIL': '/var/mail/cltbld', 05:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:16 INFO - 'MOZ_NO_REMOTE': '1', 05:17:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:16 INFO - 'NO_EM_RESTART': '1', 05:17:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:16 INFO - 'PWD': '/builds/slave/test', 05:17:16 INFO - 'SHELL': '/bin/bash', 05:17:16 INFO - 'SHLVL': '1', 05:17:16 INFO - 'TERM': 'linux', 05:17:16 INFO - 'TMOUT': '86400', 05:17:16 INFO - 'USER': 'cltbld', 05:17:16 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1498479395.904927-1339089345', 05:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:16 INFO - '_': '/tools/buildbot/bin/python'} 05:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:16 INFO - Downloading/unpacking jsonschema==2.5.1 05:17:16 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:17:16 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:17:16 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:17:16 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:17:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:17:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:18 INFO - Downloading functools32-3.2.3-2.tar.gz 05:17:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:17:18 INFO - warning: no files found matching '*.txt' 05:17:18 INFO - no previously-included directories found matching 'build' 05:17:18 INFO - no previously-included directories found matching 'dist' 05:17:18 INFO - no previously-included directories found matching '.git*' 05:17:18 INFO - Installing collected packages: jsonschema, functools32 05:17:18 INFO - Running setup.py install for functools32 05:17:18 INFO - warning: no files found matching '*.txt' 05:17:18 INFO - no previously-included directories found matching 'build' 05:17:18 INFO - no previously-included directories found matching 'dist' 05:17:18 INFO - no previously-included directories found matching '.git*' 05:17:18 INFO - Successfully installed jsonschema functools32 05:17:18 INFO - Cleaning up... 05:17:18 INFO - Return code: 0 05:17:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:17: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:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17: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:17:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:18 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 0xc573b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe31a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd59a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd3140>, '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 0xfd3a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd3ed0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1498479395.904927-1339089345', '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:17:18 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:17:18 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:17:18 INFO - Using env: {'DISPLAY': ':0', 05:17:18 INFO - 'HOME': '/home/cltbld', 05:17:18 INFO - 'LANG': 'en_US.UTF-8', 05:17:18 INFO - 'LANGUAGE': 'en_US:en', 05:17:18 INFO - 'LOGNAME': 'cltbld', 05:17:18 INFO - 'MAIL': '/var/mail/cltbld', 05:17:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:18 INFO - 'MOZ_NO_REMOTE': '1', 05:17:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:18 INFO - 'NO_EM_RESTART': '1', 05:17:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:18 INFO - 'PWD': '/builds/slave/test', 05:17:18 INFO - 'SHELL': '/bin/bash', 05:17:18 INFO - 'SHLVL': '1', 05:17:18 INFO - 'TERM': 'linux', 05:17:18 INFO - 'TMOUT': '86400', 05:17:18 INFO - 'USER': 'cltbld', 05:17:18 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1498479395.904927-1339089345', 05:17:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:18 INFO - '_': '/tools/buildbot/bin/python'} 05:17:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:17:18 INFO - Cleaning up... 05:17:18 INFO - Return code: 0 05:17:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:17: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:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17: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:17:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:18 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 0xc573b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe31a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd59a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd3140>, '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 0xfd3a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd3ed0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1498479395.904927-1339089345', '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:17:18 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:17:18 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:17:18 INFO - Using env: {'DISPLAY': ':0', 05:17:18 INFO - 'HOME': '/home/cltbld', 05:17:18 INFO - 'LANG': 'en_US.UTF-8', 05:17:18 INFO - 'LANGUAGE': 'en_US:en', 05:17:18 INFO - 'LOGNAME': 'cltbld', 05:17:18 INFO - 'MAIL': '/var/mail/cltbld', 05:17:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:18 INFO - 'MOZ_NO_REMOTE': '1', 05:17:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:18 INFO - 'NO_EM_RESTART': '1', 05:17:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:18 INFO - 'PWD': '/builds/slave/test', 05:17:18 INFO - 'SHELL': '/bin/bash', 05:17:18 INFO - 'SHLVL': '1', 05:17:18 INFO - 'TERM': 'linux', 05:17:18 INFO - 'TMOUT': '86400', 05:17:18 INFO - 'USER': 'cltbld', 05:17:18 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1498479395.904927-1339089345', 05:17:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:18 INFO - '_': '/tools/buildbot/bin/python'} 05:17:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:18 INFO - Downloading/unpacking blobuploader==1.2.4 05:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:19 INFO - Downloading blobuploader-1.2.4.tar.gz 05:17:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:17:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:17:19 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:17:19 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:17:19 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:17:19 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:17:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:17:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:17: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:17: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:17: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:17: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:17:20 INFO - Downloading docopt-0.6.1.tar.gz 05:17:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:17:20 INFO - Installing collected packages: blobuploader, requests, docopt 05:17:20 INFO - Running setup.py install for blobuploader 05:17:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:17:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:17:20 INFO - Running setup.py install for requests 05:17:20 INFO - Running setup.py install for docopt 05:17:21 INFO - Successfully installed blobuploader requests docopt 05:17:21 INFO - Cleaning up... 05:17:21 INFO - Return code: 0 05:17:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17: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:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17: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:17:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:21 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 0xc573b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe31a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd59a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd3140>, '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 0xfd3a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd3ed0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1498479395.904927-1339089345', '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:17:21 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:17:21 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:17:21 INFO - Using env: {'DISPLAY': ':0', 05:17:21 INFO - 'HOME': '/home/cltbld', 05:17:21 INFO - 'LANG': 'en_US.UTF-8', 05:17:21 INFO - 'LANGUAGE': 'en_US:en', 05:17:21 INFO - 'LOGNAME': 'cltbld', 05:17:21 INFO - 'MAIL': '/var/mail/cltbld', 05:17:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:21 INFO - 'MOZ_NO_REMOTE': '1', 05:17:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:21 INFO - 'NO_EM_RESTART': '1', 05:17:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:21 INFO - 'PWD': '/builds/slave/test', 05:17:21 INFO - 'SHELL': '/bin/bash', 05:17:21 INFO - 'SHLVL': '1', 05:17:21 INFO - 'TERM': 'linux', 05:17:21 INFO - 'TMOUT': '86400', 05:17:21 INFO - 'USER': 'cltbld', 05:17:21 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1498479395.904927-1339089345', 05:17:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:21 INFO - '_': '/tools/buildbot/bin/python'} 05:17:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:17:21 INFO - Running setup.py (path:/tmp/pip-X3Mu5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:17:21 INFO - Running setup.py (path:/tmp/pip-g0UeYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:17:21 INFO - Running setup.py (path:/tmp/pip-4QleZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:17:21 INFO - Running setup.py (path:/tmp/pip-fnAdIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:17:21 INFO - Running setup.py (path:/tmp/pip-0X4EuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:17:21 INFO - Running setup.py (path:/tmp/pip-CfIeoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:17:21 INFO - Running setup.py (path:/tmp/pip-8RXO5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:17:21 INFO - Running setup.py (path:/tmp/pip-FaDgLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:17:21 INFO - Running setup.py (path:/tmp/pip-cqxvBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:17:21 INFO - Running setup.py (path:/tmp/pip-TIIyPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:17:22 INFO - Running setup.py (path:/tmp/pip-jqpcIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:17:22 INFO - Running setup.py (path:/tmp/pip-z_WfLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:17:22 INFO - Running setup.py (path:/tmp/pip-UCk8T3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:17:22 INFO - Running setup.py (path:/tmp/pip-fVUBZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:22 INFO - Running setup.py (path:/tmp/pip-j9XBO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:17:22 INFO - Running setup.py (path:/tmp/pip-N6yjit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:17:22 INFO - Running setup.py (path:/tmp/pip-YXEhtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:17:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:17:22 INFO - Running setup.py install for manifestparser 05:17:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:17:22 INFO - Running setup.py install for mozcrash 05:17:22 INFO - Running setup.py install for mozdebug 05:17:22 INFO - Running setup.py install for mozdevice 05:17:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:17:22 INFO - Running setup.py install for mozfile 05:17:23 INFO - Running setup.py install for mozhttpd 05:17:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:17:23 INFO - Running setup.py install for mozinfo 05:17:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:17:23 INFO - Running setup.py install for mozInstall 05:17:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:17:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:17:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:17:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:17:23 INFO - Running setup.py install for mozleak 05:17:23 INFO - Running setup.py install for mozlog 05:17:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:17:23 INFO - Running setup.py install for moznetwork 05:17:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:17:23 INFO - Running setup.py install for mozprocess 05:17:23 INFO - Running setup.py install for mozprofile 05:17:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:17:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:17:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:17:23 INFO - Running setup.py install for mozrunner 05:17:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:17:23 INFO - Running setup.py install for mozscreenshot 05:17:24 INFO - Running setup.py install for moztest 05:17:24 INFO - Running setup.py install for mozversion 05:17:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:17:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:17:24 INFO - Cleaning up... 05:17:24 INFO - Return code: 0 05:17:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17: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:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17: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:17:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:24 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 0xc573b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe31a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd59a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd3140>, '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 0xfd3a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd3ed0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1498479395.904927-1339089345', '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:17:24 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:17:24 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:17:24 INFO - Using env: {'DISPLAY': ':0', 05:17:24 INFO - 'HOME': '/home/cltbld', 05:17:24 INFO - 'LANG': 'en_US.UTF-8', 05:17:24 INFO - 'LANGUAGE': 'en_US:en', 05:17:24 INFO - 'LOGNAME': 'cltbld', 05:17:24 INFO - 'MAIL': '/var/mail/cltbld', 05:17:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:24 INFO - 'MOZ_NO_REMOTE': '1', 05:17:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:24 INFO - 'NO_EM_RESTART': '1', 05:17:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:24 INFO - 'PWD': '/builds/slave/test', 05:17:24 INFO - 'SHELL': '/bin/bash', 05:17:24 INFO - 'SHLVL': '1', 05:17:24 INFO - 'TERM': 'linux', 05:17:24 INFO - 'TMOUT': '86400', 05:17:24 INFO - 'USER': 'cltbld', 05:17:24 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1498479395.904927-1339089345', 05:17:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:24 INFO - '_': '/tools/buildbot/bin/python'} 05:17:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:17:24 INFO - Running setup.py (path:/tmp/pip-0xxOhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:17:24 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:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:17:24 INFO - Running setup.py (path:/tmp/pip-sT0qDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:17:24 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:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:17:24 INFO - Running setup.py (path:/tmp/pip-7G49aP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:17:24 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:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:17:24 INFO - Running setup.py (path:/tmp/pip-A9Q6BV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:17:24 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:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:17:24 INFO - Running setup.py (path:/tmp/pip-L37nYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:17:24 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:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:17:24 INFO - Running setup.py (path:/tmp/pip-PgbFq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:17:24 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:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:17:24 INFO - Running setup.py (path:/tmp/pip-bAbEiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:17:25 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:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:17:25 INFO - Running setup.py (path:/tmp/pip-2_nSWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:17:25 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:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:17:25 INFO - Running setup.py (path:/tmp/pip-KOjuwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:17:25 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:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:17:25 INFO - Running setup.py (path:/tmp/pip-E5s7LT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:17:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:17:25 INFO - Running setup.py (path:/tmp/pip-O0gfta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:17:25 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:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:17:25 INFO - Running setup.py (path:/tmp/pip-88QlYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:17:25 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:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:17:25 INFO - Running setup.py (path:/tmp/pip-_86NWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:17:25 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:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:17:25 INFO - Running setup.py (path:/tmp/pip-J1Uicf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:17:25 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:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:25 INFO - Running setup.py (path:/tmp/pip-VFpByk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:25 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:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:17:25 INFO - Running setup.py (path:/tmp/pip-0vwSyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:17:25 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:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:17:25 INFO - Running setup.py (path:/tmp/pip-s10_1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:17:25 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:17:25 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:17:25 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:17:25 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:17:25 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:17:25 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:17:25 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:17:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:17:25 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:17:25 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:17:25 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:17:25 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:17:26 INFO - Downloading blessings-1.6.tar.gz 05:17:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:17:26 INFO - Installing collected packages: blessings 05:17:26 INFO - Running setup.py install for blessings 05:17:27 INFO - Successfully installed blessings 05:17:27 INFO - Cleaning up... 05:17:27 INFO - Return code: 0 05:17:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:17:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:17:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:17:27 INFO - Reading from file tmpfile_stdout 05:17:27 INFO - Current package versions: 05:17:27 INFO - argparse == 1.2.1 05:17:27 INFO - blessings == 1.6 05:17:27 INFO - blobuploader == 1.2.4 05:17:27 INFO - docopt == 0.6.1 05:17:27 INFO - functools32 == 3.2.3-2 05:17:27 INFO - jsonschema == 2.5.1 05:17:27 INFO - manifestparser == 1.1 05:17:27 INFO - mozInstall == 1.13 05:17:27 INFO - mozcrash == 1.0 05:17:27 INFO - mozdebug == 0.1 05:17:27 INFO - mozdevice == 0.51 05:17:27 INFO - mozfile == 1.2 05:17:27 INFO - mozhttpd == 0.7 05:17:27 INFO - mozinfo == 0.10 05:17:27 INFO - mozleak == 0.1 05:17:27 INFO - mozlog == 3.4 05:17:27 INFO - moznetwork == 0.27 05:17:27 INFO - mozprocess == 0.25 05:17:27 INFO - mozprofile == 0.28 05:17:27 INFO - mozrunner == 6.13 05:17:27 INFO - mozscreenshot == 0.1 05:17:27 INFO - mozsystemmonitor == 0.3 05:17:27 INFO - moztest == 0.8 05:17:27 INFO - mozversion == 1.4 05:17:27 INFO - psutil == 3.1.1 05:17:27 INFO - requests == 1.2.3 05:17:27 INFO - wsgiref == 0.1.2 05:17:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:27 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 0xc573b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe31a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd59a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd3140>, '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 0xfd3a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd3ed0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1498479395.904927-1339089345', '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:17:27 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:17:27 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:17:27 INFO - Using env: {'DISPLAY': ':0', 05:17:27 INFO - 'HOME': '/home/cltbld', 05:17:27 INFO - 'LANG': 'en_US.UTF-8', 05:17:27 INFO - 'LANGUAGE': 'en_US:en', 05:17:27 INFO - 'LOGNAME': 'cltbld', 05:17:27 INFO - 'MAIL': '/var/mail/cltbld', 05:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:27 INFO - 'MOZ_NO_REMOTE': '1', 05:17:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:27 INFO - 'NO_EM_RESTART': '1', 05:17:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:27 INFO - 'PWD': '/builds/slave/test', 05:17:27 INFO - 'SHELL': '/bin/bash', 05:17:27 INFO - 'SHLVL': '1', 05:17:27 INFO - 'TERM': 'linux', 05:17:27 INFO - 'TMOUT': '86400', 05:17:27 INFO - 'USER': 'cltbld', 05:17:27 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1498479395.904927-1339089345', 05:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:27 INFO - '_': '/tools/buildbot/bin/python'} 05:17:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:27 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:17:27 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:17:27 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:17:27 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:17:27 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:17:27 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:17:27 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:17:27 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:17:27 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:17:27 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:28 INFO - Downloading marionette_driver-1.4.0.tar.gz 05:17:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 05:17:28 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:17:28 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:17:28 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:17:28 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:17:28 INFO - Installing collected packages: marionette-driver 05:17:28 INFO - Running setup.py install for marionette-driver 05:17:28 INFO - Successfully installed marionette-driver 05:17:28 INFO - Cleaning up... 05:17:28 INFO - Return code: 0 05:17:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:17:28 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:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:28 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:17:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:28 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 0xc573b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe31a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd59a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd3140>, '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 0xfd3a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd3ed0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1498479395.904927-1339089345', '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:17:28 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:17:28 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:17:28 INFO - Using env: {'DISPLAY': ':0', 05:17:28 INFO - 'HOME': '/home/cltbld', 05:17:28 INFO - 'LANG': 'en_US.UTF-8', 05:17:28 INFO - 'LANGUAGE': 'en_US:en', 05:17:28 INFO - 'LOGNAME': 'cltbld', 05:17:28 INFO - 'MAIL': '/var/mail/cltbld', 05:17:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:28 INFO - 'MOZ_NO_REMOTE': '1', 05:17:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:28 INFO - 'NO_EM_RESTART': '1', 05:17:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:28 INFO - 'PWD': '/builds/slave/test', 05:17:28 INFO - 'SHELL': '/bin/bash', 05:17:28 INFO - 'SHLVL': '1', 05:17:28 INFO - 'TERM': 'linux', 05:17:28 INFO - 'TMOUT': '86400', 05:17:28 INFO - 'USER': 'cltbld', 05:17:28 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1498479395.904927-1339089345', 05:17:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:28 INFO - '_': '/tools/buildbot/bin/python'} 05:17:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:17:29 INFO - Cleaning up... 05:17:29 INFO - Return code: 0 05:17:29 INFO - Running post-action listener: _resource_record_post_action 05:17:29 INFO - Running post-action listener: _start_resource_monitoring 05:17:29 INFO - Starting resource monitoring. 05:17:29 INFO - [mozharness: 2017-06-26 12:17:29.058469Z] Finished create-virtualenv step (success) 05:17:29 INFO - [mozharness: 2017-06-26 12:17:29.058983Z] Running install step. 05:17:29 INFO - Running pre-action listener: _resource_record_pre_action 05:17:29 INFO - Running main action method: install 05:17:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:17:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:17:29 INFO - Reading from file tmpfile_stdout 05:17:29 INFO - Detecting whether we're running mozinstall >=1.0... 05:17:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:17:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:17:29 INFO - Reading from file tmpfile_stdout 05:17:29 INFO - Output received: 05:17:29 INFO - Usage: mozinstall [options] installer 05:17:29 INFO - Options: 05:17:29 INFO - -h, --help show this help message and exit 05:17:29 INFO - -d DEST, --destination=DEST 05:17:29 INFO - Directory to install application into. [default: 05:17:29 INFO - "/builds/slave/test"] 05:17:29 INFO - --app=APP Application being installed. [default: firefox] 05:17:29 INFO - mkdir: /builds/slave/test/build/application 05:17:29 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:17:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:17:47 INFO - Reading from file tmpfile_stdout 05:17:47 INFO - Output received: 05:17:47 INFO - /builds/slave/test/build/application/firefox/firefox 05:17:47 INFO - Running post-action listener: _resource_record_post_action 05:17:47 INFO - [mozharness: 2017-06-26 12:17:47.279920Z] Finished install step (success) 05:17:47 INFO - [mozharness: 2017-06-26 12:17:47.280199Z] Running setup-mitmproxy step. 05:17:47 INFO - Running pre-action listener: _resource_record_pre_action 05:17:47 INFO - Running main action method: setup_mitmproxy 05:17:47 INFO - Skipping: mitmproxy is not required 05:17:47 INFO - Running post-action listener: _resource_record_post_action 05:17:47 INFO - [mozharness: 2017-06-26 12:17:47.281384Z] Finished setup-mitmproxy step (success) 05:17:47 INFO - [mozharness: 2017-06-26 12:17:47.281627Z] Running run-tests step. 05:17:47 INFO - Running pre-action listener: _resource_record_pre_action 05:17:47 INFO - Running main action method: run_tests 05:17:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:17:47 INFO - Python 2.7.3 05:17:47 INFO - Return code: 0 05:17:47 INFO - grabbing minidump binary from tooltool 05:17:47 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:17:47 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 0xfd3140>, '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 0xfd3a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd3ed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:17:47 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:17:47 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:17:47 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:17:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:17:47 INFO - Return code: 0 05:17:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:17:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:17:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:17:47 INFO - ENV: RUST_BACKTRACE is now 1 05:17:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:17:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:17:47 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/VWKTNCDOTqGeauhoZVS7QQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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:17:47 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/VWKTNCDOTqGeauhoZVS7QQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-006 --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:17:47 INFO - Using env: {'DISPLAY': ':0', 05:17:47 INFO - 'HOME': '/home/cltbld', 05:17:47 INFO - 'LANG': 'en_US.UTF-8', 05:17:47 INFO - 'LANGUAGE': 'en_US:en', 05:17:47 INFO - 'LOGNAME': 'cltbld', 05:17:47 INFO - 'MAIL': '/var/mail/cltbld', 05:17:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:17:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:47 INFO - 'MOZ_NO_REMOTE': '1', 05:17:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:17:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:47 INFO - 'NO_EM_RESTART': '1', 05:17:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:47 INFO - 'PWD': '/builds/slave/test', 05:17:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:17:47 INFO - 'RUST_BACKTRACE': '1', 05:17:47 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:17:47 INFO - 'SHELL': '/bin/bash', 05:17:47 INFO - 'SHLVL': '1', 05:17:47 INFO - 'TERM': 'linux', 05:17:47 INFO - 'TMOUT': '86400', 05:17:47 INFO - 'USER': 'cltbld', 05:17:47 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1498479395.904927-1339089345', 05:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:47 INFO - '_': '/tools/buildbot/bin/python'} 05:17:47 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/VWKTNCDOTqGeauhoZVS7QQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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:17:47 INFO - mozversion application_buildid: 20170626112703 05:17:47 INFO - mozversion application_changeset: af9a8cebd43fb23822be25c5d4d065d5e9e195b8 05:17:47 INFO - mozversion application_display_name: Nightly 05:17:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:17:47 INFO - mozversion application_name: Firefox 05:17:47 INFO - mozversion application_remotingname: firefox 05:17:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:17:47 INFO - mozversion application_vendor: Mozilla 05:17:47 INFO - mozversion application_version: 56.0a1 05:17:47 INFO - mozversion platform_buildid: 20170626112703 05:17:47 INFO - mozversion platform_changeset: af9a8cebd43fb23822be25c5d4d065d5e9e195b8 05:17:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:17:47 INFO - mozversion platform_version: 56.0a1 05:17:47 INFO - using testdate: 1498479467 05:17:47 INFO - actual date: 1498479467 05:17:47 INFO - starting webserver on 'localhost:58743' 05:17:47 INFO - SUITE-START | Running 2 tests 05:17:47 INFO - TEST-START | dromaeo_css 05:17:47 INFO - operating with platform_type : linux_ 05:17:47 INFO - Initialising browser for dromaeo_css test... 05:17:47 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58743/getInfo.html -profile /tmp/tmp8aMu2O/profile 05:17:47 INFO - TEST-INFO | started process 4154 (/builds/slave/test/build/application/firefox/firefox http://localhost:58743/getInfo.html) 05:17:53 INFO - TEST-INFO | 4154: exit 0 05:17:53 INFO - Browser initialized. 05:17:53 INFO - Running cycle 1/1 for dromaeo_css test... 05:17:53 INFO - TEST-INFO | started process 4362 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8aMu2O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:18:05 INFO - PID 4362 | RSS: Main: 168509440 05:18:05 INFO - PID 4362 | 05:21:09 INFO - PID 4362 | Cycle 1(1): loaded http://localhost:58743/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58743/tests/dromaeo/cssquery-ext.html) 05:21:11 INFO - PID 4362 | RSS: Main: 174936064 05:21:11 INFO - PID 4362 | 05:24:12 INFO - PID 4362 | Cycle 1(1): loaded http://localhost:58743/tests/dromaeo/cssquery-ext.html (next: http://localhost:58743/tests/dromaeo/cssquery-jquery.html) 05:24:13 INFO - PID 4362 | RSS: Main: 173588480 05:24:13 INFO - PID 4362 | 05:27:14 INFO - PID 4362 | Cycle 1(1): loaded http://localhost:58743/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58743/tests/dromaeo/cssquery-mootools.html) 05:27:15 INFO - PID 4362 | RSS: Main: 175472640 05:27:15 INFO - PID 4362 | 05:30:17 INFO - PID 4362 | Cycle 1(1): loaded http://localhost:58743/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58743/tests/dromaeo/cssquery-prototype.html) 05:30:17 INFO - PID 4362 | RSS: Main: 175136768 05:30:17 INFO - PID 4362 | 05:33:20 INFO - PID 4362 | Cycle 1(1): loaded http://localhost:58743/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58743/tests/dromaeo/cssquery-yui.html) 05:33:20 INFO - PID 4362 | RSS: Main: 174145536 05:33:20 INFO - PID 4362 | 05:36:22 INFO - PID 4362 | Cycle 1(1): loaded http://localhost:58743/tests/dromaeo/cssquery-yui.html (next: http://localhost:58743/tests/dromaeo/cssquery-dojo.html) 05:36:22 INFO - PID 4362 | RSS: Main: 176975872 05:36:22 INFO - PID 4362 | 05:36:22 INFO - PID 4362 | __start_tp_report 05:36:22 INFO - PID 4362 | _x_x_mozilla_page_load 05:36:22 INFO - PID 4362 | _x_x_mozilla_page_load_details 05:36:22 INFO - PID 4362 | |i|pagename|runs| 05:36:22 INFO - PID 4362 | |0;dojo.html;3113.5641010258582;3149.4960806270988;3152.700493453122;3184.984075079625;3188.995466428075;6079.361667024965;6093.086037094438;6099.573029887904;6126.02914498734;6129.053167990504;5974.6713930733795;6096.725647345869;6127.586602260213;6131;6141.324454310023;5689.032864413039;5691;5742.425757424245;5752.7986520471795;5761.510271626917;5714.828555143332;5749.770009199627;5796.8260952171295;5798.536117110621;5799;5540.473655002768;5608.55131589476;5673.432656734335;5679.630823996427;5681.57388195887;5522;5561.221428999943;5593.188987596775;5614.578906582023;5625.212470254168;5598.076317407623;5672.744726487318;5684.744186511617;5707.71461426927;5719.14212868069;6091.512678985715;6118.755249790003;6123.173371594822;6131.41751533608;6138.539609529304;6605.896411162155;6699.531032827704;6702.162229721285;6706.731730730765;6718.49611279156;6505.4795616350575;6583.407493325576;6641.86716265672;6652.301508341603;6686.699098540577;6126.151269885628;6157.84605384869;6196.10156527301;6197.163382943245;6217.6891155442045;6825.69284382204;6847.1783385993;6850.897236541456;6853;6869.656517174221;6332.366763323723;6435.646039467781;6440.066190402459;6444.162258906406;6448.871022579616;6503;6540.117084193668;6603.735850565923;6626.304238054935;6645.269020407752;6632.502562307846;6657.3342665733035;6664.766733164413;6675.365840245169;6681.09805176295;6452.580582262138;6691.397774200345;6715.026321183401;6716.496262780311;6720.260771315151;5329.333833270841;5345.919811202835;5356.464353564613;5422.484863937999;5455.345358556999;4572.702774319659;4620.699654522446;4635.976820115878;4645.581897629229;4659.44086709597;5737.971310143423;5750.971245143831;5778.5377169826315;5796.88406231873;5842.415758424208;6687.699053542505;6721.630310332881;6741;6785.5250132490255;6789.219239787488;5681.57388195887;5791.82624521265;5821.650700957956;5830.067189249785;5844.532437404998;5783.971080144656;5801.303843538718;5832.795852145155;5877.764889404376;5878.470937615635;6338.556301058881;6394.840128996812;6445.774397896051;6499.870002599827;6522.412982831378;6726.730930762715;6730.394264516217;6733.192016957996;6733.6296503692765;6735.562188457735;6505.154329937078;6508.023796430573;6509.349065093453;6516.989866570689;6522.673866306761;6400.039994000937;6509.674516274073;6529.020646903003;6608;6635.8009259722285;6577.309382514958;6589.670516474253;6667.933320666925;6671.132752742113;6673.1324927761025;6445.774397896051;6490.902636460362;6499.837504062436;6502.284748677736;6527.804165875032;6429.7106630200815;6493.026046093124;6495.447886929664;6533.738650453929;6537.411632953057;6222.751089956351;6308.747650093945;6328.114064030948;6385.68071596409;6428.067930150196;6411.4870810336;6472.255690595453;6474.805755827333;6487.870242595027;6495.675216239264;6321.96839015802;6373.107764913008;6385.265694445198;6387.68061596909;6417.454516365974 05:36:22 INFO - PID 4362 | |1;ext.html;797.9760607181787;830.9709160179395;849.6006876767918;880.0231742765529;880.0978996528557;39429.60570394295;39933.40099898504;40095;40241.99395015123;40243.396349054754;36401.45397819028;36579.45130823033;36895.70865019725;37075.25849483009;37095;6880.7591734289435;6941.2017617973825;7025.086738723959;7026.367626913577;7035.1557813062245;6901.309869013109;7032.296770322952;7036.612986285778;7046.964765176167;7059.294070592951;7014.403775679073;7022.192447868484;7033.753818616349;7042.366187043165;7048;6980.162380514345;7016.36852683261;7019.333163349474;7021.648917554102;7031.085958825345;6363.87272254557;6377.776777812801;6430.1319321891415;6435.967820160869;6441;32931.50602740937;32992.17519562006;32993.50509742356;33045;33188.33623327544;3388.0344101931078;3434.5706786651667;3434.639362866913;3439.724822014258;3589.6589823966942;30411.087667370015;30547.694523054706;30570;30641.233969150726;30647.846760766275;3746.7939263340504;3782.5082739244;3795.886123416302;3796.4305354196817;3823.445600387956;184975;185441;185492;186877.0656146724;187592;42853.35719964203;47258;48167.51832481701;48209;48348;49760;50068.24897626466;50077.74961125244;50089.24866127011;50165;15592.766108508382;15671.764923526156;15695.68608627821;15702.68594628101;15734.291956861969;12877.4205160768;12904.290264035568;12909.870901291055;12970.935145324402;13001.284929328978;13700.65748356279;13703.588892333246;13713.108647937852;13813.723725525433;13962.301884905917;5427.1316589345515;5485.6434331768305;5493.258410114663;5575.4424557543925;5636.126400407943;1003.2375394700081;1022.1209759606733;1023.125227930124;1047.3349423116224;1063.4629512096496;22970;23087.653685194735;23132.53734925292;23346.2996110117;23645.881770591383;1089.9237053406187;1090.5637744902103;1139.7834411461795;1143.6340371081174;1146.587228597704;11940.44774179351;12875;12908.096433249582;12967.640684552574;12977.171734338393;229236;236276;239604;240007;242014;57277.713611431675;58368;58577.41422585805;58675.41324586785;58910;1510.9622259443381;1511.4860947277978;1517.6627992890824;1524.6264665156887;1527.5646440764328;26647.86676066607;28679.713202867704;28882.855585721936;28994.260344379403;29061.273468163465;49811;50556;50706.74646626743;50984.49015509798;50988.23517647312;195440;197562;197982;198278;198511;31755.523667145473;31794.68205317917;31943.840280798446;32020.83989580037;35713;37406.251874962894;42324.36513452239;42950.570494294654;43089;43628;30299.697003029687;30510.542341865334;30676.23309417193;31582.210444739067;32506.51240231351;25273.62089568621;26289.21132366032;26335.473290534464;26514.337141571614;26546.60180097339;33694.3261134771;33720.83139584286;33867.98396048122;34711.30577388489;34753.65246347605;28576.57135142933;30168.698313017467;30202.697973020866;30377.240568985068;31042;23162;23710.288691339287;24512;24531.14141005056;24612.261632151065 05:36:22 INFO - PID 4362 | |2;jquery.html;529.5472371122693;530.358266497538;538.2760187547749;575.2694078520278;593.2554643921877;21592.568148637038;22382.21662241822;22400.439989000242;22432.990515426805;22458.663120053214;23517.647235291483;24369.512609747795;25493.87253063732;25594.232173034794;25770.87114564429;6231.626102433857;6324.367563243685;6331.2085989251345;6331.77838775643;6376.808695739135;6304.968475157618;6313.936860631381;6352.396522330371;6364.649944253064;6409.743610255584;5889.146073819294;6197.938020619781;6299.590526615778;6334.746610135589;6342.619442833422;6234.657093859859;6240.6879656017245;6258.249010118792;6289.779857705004;6296.779612713579;5822.854428639275;5877.235959325303;5887.8233652990475;5889.087191485284;5898.616589921641;27196.864015679796;27920.30199245015;28280.010199642915;28320.716792832012;28371.716282837115;1850;1897.8197071278207;1916.1377380178976;1918.3094086129122;1919.395390452003;18208.63582728338;18523.62952740951;18635.347762828234;18689.06554672261;18797.342093026815;2268.274152271274;2321.141177764221;2342.7071616047992;2368.857868527894;2370.8340416170877;120854.3957280208;124720.37639811833;124733;125568.37215813954;126259.3687031559;13953.860461395256;14601.19693416851;15126.848731512764;15131.54605361841;15178.392864285526;23248.767512324997;23266.65100023501;23505.7649423507;23543.88228058849;23563.0574777007;9998.700038998843;10117.140043096271;10189.133923616428;10305.690829275134;10429.322094063862;9265.44407335562;9313.627454901864;9392.718218453458;9509.90490095104;9521.952390238004;8877.091425343582;9001;9002.459852408876;9172.770680733034;9282.211012063915;2676.5717485202276;2694.178275625953;2764.3918337966015;2765.5436852919042;2932.3402234497066;930.3208657679932;961.9374740641836;972.8832540095234;978.5449765858909;1001.6944831826218;23213.88393058024;24709.135180268604;25761;25865.48269034609;25905.35236619062;1022.504085518523;1042.6611351310855;1044.2637940252105;1050.495762034228;1052.2686732720838;11374.090072794157;11439;11510.079193664487;11510.884891150981;11604.071674266039;494874;510502;511821;514957;516157;100792;106378;106874.46562767136;107696.4615176919;109407;1205.825155352469;1228.9631311060682;1255.6233130060946;1260.9306488143056;1261.779188641984;18604.25582976666;20992.370228893156;21122.788772112082;21207.257745978815;21366;48890.75554622347;51831.222531661304;52280.73859630677;52290.738546307024;53218.2017269749;65515;66554.66722666356;66568.66715666391;66786;66876;12532.122751407314;12874.905633021299;12907.935460322638;12960.805587916377;12982.415791289604;17735.645287094445;18629.44111676652;18672.626547468702;18763.71854422212;18856.434306970812;15091.169985650895;15103.924480377527;15295.694086118438;15556.533304000897;15704.371825126867;13274.535391261259;13445.260510672008;14065.929670351583;14420.062695924731;14488.058276212434;14988;15076.698466030837;15213;15800.60498487547;16157.919210403872;12841.101122921305;12921.547745828851;12935.547255846;12968;12992.545260915822;15256.313465894284;15296.923515382352;15349;15364;15399.692006160038 05:36:22 INFO - PID 4362 | |3;mootools.html;1379.772337564302;1448.7175000874834;1449.4492093004656;1453.505808025271;1464.4142343062774;13277.535286264983;13866.514671986482;13870.791938120923;13915.930420347897;13927.303634818269;13346.53287134948;13730.58808235752;13735.862641373607;13744.381502832372;13750.724985500285;2574.1119313836743;2582.044643481905;2611.086119858044;2611.2949503634104;2622.5672763993916;2536.6321883326905;2589.779868711152;2591.06721580231;2598.350412396901;2599.1812579037637;2428.1258746851117;2447.853128812268;2463.224084413404;2464.728879823218;2484.0312278211513;2507.3104896153613;2608.400067984365;2616.699079605851;2622.10848311575;2622.5803871380676;2440.9389765255833;2463.6550882876413;2472.925812225636;2477.2072936660275;2486.651868738378;13212.86787132126;13364.665883352896;13475.19148851072;13486.39311230997;13543.255120968342;7099.077119974422;7324.743633972786;7371.189169191384;7401.555906645618;7410.147832999221;4125.64931980782;4239.957600423987;4345.847895323648;4354.368616550582;4393.494748103945;1599.3202888772225;1621.0759866875885;1630.7064728348892;1650.2243945345788;1689.754985527104;20831.5833683327;20946.476338091517;21093.15627374903;21151.788482115135;21159;5929.792457263975;5938.8218353449465;5979.1629171915965;6126.632402055891;6173;14046.648833779032;14104.71790564183;14110.647233819236;14121;14148.858511414754;7034.19106802714;7249.8550028999125;7268.309510596485;7272.127344718562;7308.890366644505;6722.9663851680425;6726.159230096238;6768.052472653832;6824.351686589766;6841.897371539431;5009.774560144802;5022.698638081727;5043.9747801260755;5072.67027643202;5153.1497302945345;1463.0928824129107;1465.5310300703673;1473.8378778334375;1484.3913995261892;1502.6243439140214;868.2793281576277;876.9429987050821;889.6308032166578;896.8430524658158;914.9222316103072;6876.243613202544;6992;7153.96423017892;7288.3076107769675;7567.508111972704;713.8643657705123;729.2634439216324;731.1701219116235;732.7105793211651;735.1692587376338;4416.403785488982;4970.850874473772;5009.799608015638;5190.455002224788;5277.551408130275;16709.498715038568;16774.83225167757;17253.482395528154;17391.826081739273;17429.564260893578;16371;16758;17098.743518847226;17170.742438863428;17610.295588176585;9703.757406065046;9943.30396872212;10034.799304014025;10081.69754907354;10088.092071713434;7498.962505187439;7658.119316278699;7677.193894640982;7820.45256832039;7982.281594656509;14518.491852785102;15047.774283385977;15080.849191507945;15340.76988845146;15344.616384590474;15239.847601523843;15673.137977411352;15765.054096754231;15797.131157786433;16291.837081629032;9866.950665246628;10014.349067310894;10025.097741203326;10029.69910902674;10071.143952763805;11768.882311177122;12267.202631828903;12349.135560510678;12421.689457763629;12447.502099915902;9770.609175632895;9976.15202707778;10161.593536258466;10385.324953877975;10456;9520.428774273565;9732.464714440774;10059.547320370748;10072.899271007196;10190.082892539707;9351.53242337894;9399.671011514563;9463.621455141718;9470.95264523673;9510.572024259063;6601.900971485527;6619.669016549057;6690.962900750392;6694.397504224643;6969.477289203432;7052.153741551047;7054.823629409306;7088.503804733826;7306.123265208209;7340.1191856975365 05:36:22 INFO - PID 4362 | |4;prototype.html;476.2094922428769;485.9854204373869;494.45115921327323;495.16070260907776;521.8173639226269;6192.566520343577;6226.346233645464;6260.154879091321;6271.090691849679;6280.968595157018;5926.822195334136;6031.577789554733;6078.939210607892;6088.330283668793;6096.439495411926;4971.179755340365;4977.153883839738;4995.100881841267;4995.425526064513;5011.942714943882;5006.499350065001;5010.574101201402;5012.799488020475;5014.548690617844;5018.34761481007;4766.118268120392;4953.306537084811;4972.129877271481;4977.452480227172;4990.27640992056;4922.26166075088;4949.653524253304;4959.330490383806;4959.454460009396;4989.226669866177;4413.44831896013;4429.512753597134;4429.867103986886;4460.576245256695;4473.015936493966;5985.426266705315;5990.2212712347555;6018.638881667114;6035.111559636708;6044.153818465418;5693.28833895763;5699;5701.543876489913;5707.5148612368;5713.542916566665;6510.3489651034515;6552.93447065528;6560.704768285391;6563.146790917198;6563.146790917198;4839.685420447659;4876.707397556158;4895.363602731658;4906.31311616374;4928.359313289286;6927.515073944826;6928.757493487754;6937.161652162181;6997.670442615887;7002.894956575656;5031.7987280509105;5050.964552266776;5054.620903432257;5058.544730974157;5059.595232381401;5127.3847138343635;5129.692218466904;5133.948660513347;5135;5141.5886729061585;5651.971740141273;5697.373288938214;5703.20155178267;5740.885182296331;5781.860711536674;6615.735370585219;6619.933800662028;6639.767608133789;6642;6667.63328016954;1648.7279598866292;1766.5318690547015;1777.9288828446977;1779.7241427578488;1789.7650621071418;1131.7679875625477;1203.3080978437433;1222.54765736678;1236.1841184818156;1245.0848626259692;5528.917066244009;5646.153077038477;5646.463585959327;5651.463111004448;5699.943000570024;6728.629925354153;6745.898811517831;6762.83092922671;6776.559523631046;6807.434290113202;5753.942460575425;5771.451712087345;5785.595008349459;5801.6809075500405;5826.1552074948895;3550.1479644885558;3575.1598374382;3588.318219538279;3597.5143355647174;3607.8196090195383;6541.182352205974;6545.345465453416;6561.40947314744;6562.737490500422;6563;6883.242843287235;6903.965480172567;6904.654767261617;6922.446204303644;6942.132233470817;6549.377809108127;6576.514447342916;6577.539572229898;6594.7032383542855;6596.670166491752;6664.966675166593;6733.494987876027;6758.560693554903;6774.86450270982;6793.898091528532;6644.667766611747;6673.9332606673315;6675.933240667531;6720.899186512304;6732.865342693217;6291.370862913672;6539.182602174728;6557.737690492327;6590.5716128451495;6594.571352862049;5477.370102438271;5481.972590137024;5492.313460817398;5494.560435165097;5499.890002199853;6752.324767523209;6766.255711871789;6766.428757072281;6768.898466522907;6809.795706128824;6442.935570644234;6529.943067933586;6559.114519539801;6561.606303621798;6577.2436169841085;6467.385598368336;6549.803505894831;6570.178727659043;6579.960212334192;6595.340465953366;6474.870502590016;6477.8704425912165;6501.4798816095545;6523.804285871432;6524.934750652433;6544.181977252843;6561.96719016421;6605;6609.834754131185;6625.503087268377;6420.55056146084;6422.775202867877;6440.742370305135;6445.775302692474;6455.7740479083 05:36:22 INFO - PID 4362 | |5;yui.html;808.179697606929;813.0771574263212;815.604431850552;840.3865178419753;851.9531425771584;17126.143692815356;17628.030458324803;17672.293108275684;17676.292948282084;17698.734518982208;15750.606234844134;15870.52388428346;17627.91186044068;18404;20351.084201210942;1035.735887348725;1036.7563622548696;1046.3512622174262;1050.5535147562293;1051.8895515970828;1053.836655318423;1054.7574057966672;1055.9366438013706;1056.7675111475462;1056.973575660607;1122.0406552397706;1124.42092322454;1124.6794663520898;1125.0886781706802;1127.9436028198597;1030.7320096774818;1058.640062378795;1072.951717172729;1117.474786850179;1122.1752012271015;785.344237561631;788.7751990682627;789.4276649429117;791.2878409431501;791.6041979010495;18363.63272734538;18368.816311836978;18440.17019234138;18455.630887382176;18604.16281267346;18583.349582764673;19396;19415.029248537518;19548.120334584837;19585.510362240915;14660.486882959045;15070.171140587263;15181.013234139746;15192.848071519255;15276.465323713617;3344.1973926257765;3378.239896023375;3378.560787097686;3379.053864917827;3379.273456206927;95910;98393.50803245937;102862.48568757183;104694;106651.46674266657;14120;14447.927760361132;14458;14576.927115364568;14643.56069317922;24452;26001.479970400487;26162.73837261603;26220.73779262221;26500.204993850217;7545.170031296553;7647.885281720779;7700.19147989453;7718.421118416029;7721.459497835098;3716.6655001050035;3719.590845007047;3744.1762812181278;3754.0427191066105;3758.9436158457647;4765.475797662254;4852.854414367504;4888.755562221946;4920.803167873317;4925.75371231437;1020.5713600287897;1058.8941105889503;1061.7982583309147;1062.8830828608848;1068.3750006246432;673.2426020726682;673.9797806065826;676.539952832069;704.0425021970117;708.2457183099982;11524.250923689933;11626.65120046383;11902.761944761056;12441.688957776129;13374.866251337557;674.1438373265925;707.5719189890145;708.1431467923767;708.5075872268827;714.6569646569676;5173.405058418255;5212.765425555784;5336.199570064521;5472.34331880169;5611.270534830446;95126;99220.50389748006;99419;101895;102735;64272;85585.57207213924;86519;89172.5541372289;90572.09427905768;68370.65814670894;74799.25200747923;76760;77144.22855771483;78464;11057.447127643747;11061.502232399722;11371.886281137082;11380.94309528447;11762.411879405825;31012.22469438192;33168.66831331656;33533.32933341271;33765.49351759676;34155.65844341624;41764.373534397615;42011.7899410501;43518.34722479102;44303.778481108675;44984.550154499346;15468.226588670746;16228.594285142966;16361.918190409448;16476.258568364214;16488.0931548766;17431;17733.20200591002;17809.554761131076;18730.812691872907;18757.437276881716;15276.694466110837;15314.46399376061;15897.205139743199;16199.67600648004;16370.345186192419;16222;16768.35512371708;18116.637667246843;18197.909010455394;18240.087995600432;16262.430814921421;16757.664846702755;16767.580810479347;16771.66456670884;16954.406595769087;12430;13042.608721738363;13791.310434478437;13867.861321386657;13914.860851391357;12275.263484190977;12364.938175309066;12371.257724536557;12706.555270565486;12991.870081299066 05:36:22 INFO - PID 4362 | __end_tp_report 05:36:22 INFO - PID 4362 | __start_cc_report 05:36:22 INFO - PID 4362 | _x_x_mozilla_cycle_collect,340 05:36:22 INFO - PID 4362 | __end_cc_report 05:36:22 INFO - PID 4362 | __startTimestamp1498480582834__endTimestamp 05:36:22 INFO - PID 4362 | 05:36:22 INFO - PID 4362 | ------- Summary: start ------- 05:36:22 INFO - PID 4362 | Number of tests: 6 05:36:22 INFO - PID 4362 | 05:36:22 INFO - PID 4362 | [#0] dojo.html Cycles:165 Average:6112.74 Median:6385.27 stddev:717.38 (11.2%) stddev-sans-first:679.91 05:36:22 INFO - PID 4362 | Values: 3113.6 3149.5 3152.7 3185.0 3189.0 6079.4 6093.1 6099.6 6126.0 6129.1 5974.7 6096.7 6127.6 6131.0 6141.3 5689.0 5691.0 5742.4 5752.8 5761.5 5714.8 5749.8 5796.8 5798.5 5799.0 5540.5 5608.6 5673.4 5679.6 5681.6 5522.0 5561.2 5593.2 5614.6 5625.2 5598.1 5672.7 5684.7 5707.7 5719.1 6091.5 6118.8 6123.2 6131.4 6138.5 6605.9 6699.5 6702.2 6706.7 6718.5 6505.5 6583.4 6641.9 6652.3 6686.7 6126.2 6157.8 6196.1 6197.2 6217.7 6825.7 6847.2 6850.9 6853.0 6869.7 6332.4 6435.6 6440.1 6444.2 6448.9 6503.0 6540.1 6603.7 6626.3 6645.3 6632.5 6657.3 6664.8 6675.4 6681.1 6452.6 6691.4 6715.0 6716.5 6720.3 5329.3 5345.9 5356.5 5422.5 5455.3 4572.7 4620.7 4636.0 4645.6 4659.4 5738.0 5751.0 5778.5 5796.9 5842.4 6687.7 6721.6 6741.0 6785.5 6789.2 5681.6 5791.8 5821.7 5830.1 5844.5 5784.0 5801.3 5832.8 5877.8 5878.5 6338.6 6394.8 6445.8 6499.9 6522.4 6726.7 6730.4 6733.2 6733.6 6735.6 6505.2 6508.0 6509.3 6517.0 6522.7 6400.0 6509.7 6529.0 6608.0 6635.8 6577.3 6589.7 6667.9 6671.1 6673.1 6445.8 6490.9 6499.8 6502.3 6527.8 6429.7 6493.0 6495.4 6533.7 6537.4 6222.8 6308.7 6328.1 6385.7 6428.1 6411.5 6472.3 6474.8 6487.9 6495.7 6322.0 6373.1 6385.3 6387.7 6417.5 05:36:22 INFO - PID 4362 | 05:36:22 INFO - PID 4362 | [#1] ext.html Cycles:180 Average:37392.69 Median:32992.84 stddev:54136.64 (164.1%) stddev-sans-first:54218.77 05:36:22 INFO - PID 4362 | Values: 798.0 831.0 849.6 880.0 880.1 39429.6 39933.4 40095.0 40242.0 40243.4 36401.5 36579.5 36895.7 37075.3 37095.0 6880.8 6941.2 7025.1 7026.4 7035.2 6901.3 7032.3 7036.6 7047.0 7059.3 7014.4 7022.2 7033.8 7042.4 7048.0 6980.2 7016.4 7019.3 7021.6 7031.1 6363.9 6377.8 6430.1 6436.0 6441.0 32931.5 32992.2 32993.5 33045.0 33188.3 3388.0 3434.6 3434.6 3439.7 3589.7 30411.1 30547.7 30570.0 30641.2 30647.8 3746.8 3782.5 3795.9 3796.4 3823.4 184975.0 185441.0 185492.0 186877.1 187592.0 42853.4 47258.0 48167.5 48209.0 48348.0 49760.0 50068.2 50077.7 50089.2 50165.0 15592.8 15671.8 15695.7 15702.7 15734.3 12877.4 12904.3 12909.9 12970.9 13001.3 13700.7 13703.6 13713.1 13813.7 13962.3 5427.1 5485.6 5493.3 5575.4 5636.1 1003.2 1022.1 1023.1 1047.3 1063.5 22970.0 23087.7 23132.5 23346.3 23645.9 1089.9 1090.6 1139.8 1143.6 1146.6 11940.4 12875.0 12908.1 12967.6 12977.2 229236.0 236276.0 239604.0 240007.0 242014.0 57277.7 58368.0 58577.4 58675.4 58910.0 1511.0 1511.5 1517.7 1524.6 1527.6 26647.9 28679.7 28882.9 28994.3 29061.3 49811.0 50556.0 50706.7 50984.5 50988.2 195440.0 197562.0 197982.0 198278.0 198511.0 31755.5 31794.7 31943.8 32020.8 35713.0 37406.3 42324.4 42950.6 43089.0 43628.0 30299.7 30510.5 30676.2 31582.2 32506.5 25273.6 26289.2 26335.5 26514.3 26546.6 33694.3 33720.8 33868.0 34711.3 34753.7 28576.6 30168.7 30202.7 30377.2 31042.0 23162.0 23710.3 24512.0 24531.1 24612.3 05:36:22 INFO - PID 4362 | 05:36:22 INFO - PID 4362 | [#2] jquery.html Cycles:180 Average:33961.75 Median:2294.71 stddev:84964.44 (3702.6%) stddev-sans-first:85165.71 05:36:22 INFO - PID 4362 | Values: 529.5 530.4 538.3 575.3 593.3 21592.6 22382.2 22400.4 22433.0 22458.7 23517.6 24369.5 25493.9 25594.2 25770.9 6231.6 6324.4 6331.2 6331.8 6376.8 6305.0 6313.9 6352.4 6364.6 6409.7 5889.1 6197.9 6299.6 6334.7 6342.6 6234.7 6240.7 6258.2 6289.8 6296.8 5822.9 5877.2 5887.8 5889.1 5898.6 27196.9 27920.3 28280.0 28320.7 28371.7 1850.0 1897.8 1916.1 1918.3 1919.4 18208.6 18523.6 18635.3 18689.1 18797.3 2268.3 2321.1 2342.7 2368.9 2370.8 120854.4 124720.4 124733.0 125568.4 126259.4 13953.9 14601.2 15126.8 15131.5 15178.4 23248.8 23266.7 23505.8 23543.9 23563.1 9998.7 10117.1 10189.1 10305.7 10429.3 9265.4 9313.6 9392.7 9509.9 9522.0 8877.1 9001.0 9002.5 9172.8 9282.2 2676.6 2694.2 2764.4 2765.5 2932.3 930.3 961.9 972.9 978.5 1001.7 23213.9 24709.1 25761.0 25865.5 25905.4 1022.5 1042.7 1044.3 1050.5 1052.3 11374.1 11439.0 11510.1 11510.9 11604.1 494874.0 510502.0 511821.0 514957.0 516157.0 100792.0 106378.0 106874.5 107696.5 109407.0 1205.8 1229.0 1255.6 1260.9 1261.8 18604.3 20992.4 21122.8 21207.3 21366.0 48890.8 51831.2 52280.7 52290.7 53218.2 65515.0 66554.7 66568.7 66786.0 66876.0 12532.1 12874.9 12907.9 12960.8 12982.4 17735.6 18629.4 18672.6 18763.7 18856.4 15091.2 15103.9 15295.7 15556.5 15704.4 13274.5 13445.3 14065.9 14420.1 14488.1 14988.0 15076.7 15213.0 15800.6 16157.9 12841.1 12921.5 12935.5 12968.0 12992.5 15256.3 15296.9 15349.0 15364.0 15399.7 05:36:22 INFO - PID 4362 | 05:36:22 INFO - PID 4362 | [#3] mootools.html Cycles:180 Average:8111.02 Median:2578.08 stddev:5370.62 (208.3%) stddev-sans-first:5361.87 05:36:22 INFO - PID 4362 | Values: 1379.8 1448.7 1449.4 1453.5 1464.4 13277.5 13866.5 13870.8 13915.9 13927.3 13346.5 13730.6 13735.9 13744.4 13750.7 2574.1 2582.0 2611.1 2611.3 2622.6 2536.6 2589.8 2591.1 2598.4 2599.2 2428.1 2447.9 2463.2 2464.7 2484.0 2507.3 2608.4 2616.7 2622.1 2622.6 2440.9 2463.7 2472.9 2477.2 2486.7 13212.9 13364.7 13475.2 13486.4 13543.3 7099.1 7324.7 7371.2 7401.6 7410.1 4125.6 4240.0 4345.8 4354.4 4393.5 1599.3 1621.1 1630.7 1650.2 1689.8 20831.6 20946.5 21093.2 21151.8 21159.0 5929.8 5938.8 5979.2 6126.6 6173.0 14046.6 14104.7 14110.6 14121.0 14148.9 7034.2 7249.9 7268.3 7272.1 7308.9 6723.0 6726.2 6768.1 6824.4 6841.9 5009.8 5022.7 5044.0 5072.7 5153.1 1463.1 1465.5 1473.8 1484.4 1502.6 868.3 876.9 889.6 896.8 914.9 6876.2 6992.0 7154.0 7288.3 7567.5 713.9 729.3 731.2 732.7 735.2 4416.4 4970.9 5009.8 5190.5 5277.6 16709.5 16774.8 17253.5 17391.8 17429.6 16371.0 16758.0 17098.7 17170.7 17610.3 9703.8 9943.3 10034.8 10081.7 10088.1 7499.0 7658.1 7677.2 7820.5 7982.3 14518.5 15047.8 15080.8 15340.8 15344.6 15239.8 15673.1 15765.1 15797.1 16291.8 9867.0 10014.3 10025.1 10029.7 10071.1 11768.9 12267.2 12349.1 12421.7 12447.5 9770.6 9976.2 10161.6 10385.3 10456.0 9520.4 9732.5 10059.5 10072.9 10190.1 9351.5 9399.7 9463.6 9471.0 9510.6 6601.9 6619.7 6691.0 6694.4 6969.5 7052.2 7054.8 7088.5 7306.1 7340.1 05:36:22 INFO - PID 4362 | 05:36:22 INFO - PID 4362 | [#4] prototype.html Cycles:180 Average:5538.07 Median:6039.63 stddev:1556.14 (25.8%) stddev-sans-first:1513.41 05:36:22 INFO - PID 4362 | Values: 476.2 486.0 494.5 495.2 521.8 6192.6 6226.3 6260.2 6271.1 6281.0 5926.8 6031.6 6078.9 6088.3 6096.4 4971.2 4977.2 4995.1 4995.4 5011.9 5006.5 5010.6 5012.8 5014.5 5018.3 4766.1 4953.3 4972.1 4977.5 4990.3 4922.3 4949.7 4959.3 4959.5 4989.2 4413.4 4429.5 4429.9 4460.6 4473.0 5985.4 5990.2 6018.6 6035.1 6044.2 5693.3 5699.0 5701.5 5707.5 5713.5 6510.3 6552.9 6560.7 6563.1 6563.1 4839.7 4876.7 4895.4 4906.3 4928.4 6927.5 6928.8 6937.2 6997.7 7002.9 5031.8 5051.0 5054.6 5058.5 5059.6 5127.4 5129.7 5133.9 5135.0 5141.6 5652.0 5697.4 5703.2 5740.9 5781.9 6615.7 6619.9 6639.8 6642.0 6667.6 1648.7 1766.5 1777.9 1779.7 1789.8 1131.8 1203.3 1222.5 1236.2 1245.1 5528.9 5646.2 5646.5 5651.5 5699.9 6728.6 6745.9 6762.8 6776.6 6807.4 5753.9 5771.5 5785.6 5801.7 5826.2 3550.1 3575.2 3588.3 3597.5 3607.8 6541.2 6545.3 6561.4 6562.7 6563.0 6883.2 6904.0 6904.7 6922.4 6942.1 6549.4 6576.5 6577.5 6594.7 6596.7 6665.0 6733.5 6758.6 6774.9 6793.9 6644.7 6673.9 6675.9 6720.9 6732.9 6291.4 6539.2 6557.7 6590.6 6594.6 5477.4 5482.0 5492.3 5494.6 5499.9 6752.3 6766.3 6766.4 6768.9 6809.8 6442.9 6529.9 6559.1 6561.6 6577.2 6467.4 6549.8 6570.2 6580.0 6595.3 6474.9 6477.9 6501.5 6523.8 6524.9 6544.2 6562.0 6605.0 6609.8 6625.5 6420.6 6422.8 6440.7 6445.8 6455.8 05:36:22 INFO - PID 4362 | 05:36:22 INFO - PID 4362 | [#5] yui.html Cycles:180 Average:20322.48 Median:18301.86 stddev:26798.39 (146.4%) stddev-sans-first:26833.51 05:36:22 INFO - PID 4362 | Values: 808.2 813.1 815.6 840.4 852.0 17126.1 17628.0 17672.3 17676.3 17698.7 15750.6 15870.5 17627.9 18404.0 20351.1 1035.7 1036.8 1046.4 1050.6 1051.9 1053.8 1054.8 1055.9 1056.8 1057.0 1122.0 1124.4 1124.7 1125.1 1127.9 1030.7 1058.6 1073.0 1117.5 1122.2 785.3 788.8 789.4 791.3 791.6 18363.6 18368.8 18440.2 18455.6 18604.2 18583.3 19396.0 19415.0 19548.1 19585.5 14660.5 15070.2 15181.0 15192.8 15276.5 3344.2 3378.2 3378.6 3379.1 3379.3 95910.0 98393.5 102862.5 104694.0 106651.5 14120.0 14447.9 14458.0 14576.9 14643.6 24452.0 26001.5 26162.7 26220.7 26500.2 7545.2 7647.9 7700.2 7718.4 7721.5 3716.7 3719.6 3744.2 3754.0 3758.9 4765.5 4852.9 4888.8 4920.8 4925.8 1020.6 1058.9 1061.8 1062.9 1068.4 673.2 674.0 676.5 704.0 708.2 11524.3 11626.7 11902.8 12441.7 13374.9 674.1 707.6 708.1 708.5 714.7 5173.4 5212.8 5336.2 5472.3 5611.3 95126.0 99220.5 99419.0 101895.0 102735.0 64272.0 85585.6 86519.0 89172.6 90572.1 68370.7 74799.3 76760.0 77144.2 78464.0 11057.4 11061.5 11371.9 11380.9 11762.4 31012.2 33168.7 33533.3 33765.5 34155.7 41764.4 42011.8 43518.3 44303.8 44984.6 15468.2 16228.6 16361.9 16476.3 16488.1 17431.0 17733.2 17809.6 18730.8 18757.4 15276.7 15314.5 15897.2 16199.7 16370.3 16222.0 16768.4 18116.6 18197.9 18240.1 16262.4 16757.7 16767.6 16771.7 16954.4 12430.0 13042.6 13791.3 13867.9 13914.9 12275.3 12364.9 12371.3 12706.6 12991.9 05:36:22 INFO - PID 4362 | -------- Summary: end -------- 05:36:22 INFO - PID 4362 | 05:36:23 INFO - TEST-INFO | 4362: exit 0 05:36:23 INFO - TEST-OK | dromaeo_css | took 1115739ms 05:36:23 INFO - TEST-START | kraken 05:36:23 INFO - operating with platform_type : linux_ 05:36:23 INFO - Initialising browser for kraken test... 05:36:23 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58743/getInfo.html -profile /tmp/tmppR25Q1/profile 05:36:23 INFO - TEST-INFO | started process 4759 (/builds/slave/test/build/application/firefox/firefox http://localhost:58743/getInfo.html) 05:36:29 INFO - TEST-INFO | 4759: exit 0 05:36:29 INFO - Browser initialized. 05:36:29 INFO - Running cycle 1/1 for kraken test... 05:36:29 INFO - TEST-INFO | started process 4965 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppR25Q1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:36:40 INFO - PID 4965 | RSS: Main: 168501248 05:36:40 INFO - PID 4965 | 05:36:43 INFO - PID 4965 | Cycle 1(1): loaded http://localhost:58743/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58743/tests/kraken/driver.html?testName=audio-beat-detection) 05:36:44 INFO - PID 4965 | RSS: Main: 173932544 05:36:44 INFO - PID 4965 | 05:36:46 INFO - PID 4965 | Cycle 1(1): loaded http://localhost:58743/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58743/tests/kraken/driver.html?testName=audio-dft) 05:36:47 INFO - PID 4965 | RSS: Main: 174268416 05:36:47 INFO - PID 4965 | 05:36:50 INFO - PID 4965 | Cycle 1(1): loaded http://localhost:58743/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58743/tests/kraken/driver.html?testName=audio-fft) 05:36:51 INFO - PID 4965 | RSS: Main: 168501248 05:36:51 INFO - PID 4965 | 05:36:53 INFO - PID 4965 | Cycle 1(1): loaded http://localhost:58743/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58743/tests/kraken/driver.html?testName=audio-oscillator) 05:36:53 INFO - PID 4965 | RSS: Main: 169431040 05:36:53 INFO - PID 4965 | 05:36:55 INFO - PID 4965 | Cycle 1(1): loaded http://localhost:58743/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58743/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:36:56 INFO - PID 4965 | RSS: Main: 169594880 05:36:56 INFO - PID 4965 | 05:36:59 INFO - PID 4965 | Cycle 1(1): loaded http://localhost:58743/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58743/tests/kraken/driver.html?testName=imaging-darkroom) 05:37:00 INFO - PID 4965 | RSS: Main: 173207552 05:37:00 INFO - PID 4965 | 05:37:03 INFO - PID 4965 | Cycle 1(1): loaded http://localhost:58743/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58743/tests/kraken/driver.html?testName=imaging-desaturate) 05:37:04 INFO - PID 4965 | RSS: Main: 173973504 05:37:04 INFO - PID 4965 | 05:37:06 INFO - PID 4965 | Cycle 1(1): loaded http://localhost:58743/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58743/tests/kraken/driver.html?testName=json-parse-financial) 05:37:07 INFO - PID 4965 | RSS: Main: 173522944 05:37:07 INFO - PID 4965 | 05:37:09 INFO - PID 4965 | Cycle 1(1): loaded http://localhost:58743/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58743/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:37:09 INFO - PID 4965 | RSS: Main: 173535232 05:37:09 INFO - PID 4965 | 05:37:11 INFO - PID 4965 | Cycle 1(1): loaded http://localhost:58743/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58743/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:37:12 INFO - PID 4965 | RSS: Main: 173535232 05:37:12 INFO - PID 4965 | 05:37:14 INFO - PID 4965 | Cycle 1(1): loaded http://localhost:58743/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58743/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:37:14 INFO - PID 4965 | RSS: Main: 173281280 05:37:14 INFO - PID 4965 | 05:37:17 INFO - PID 4965 | Cycle 1(1): loaded http://localhost:58743/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58743/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:37:18 INFO - PID 4965 | RSS: Main: 172912640 05:37:18 INFO - PID 4965 | 05:37:21 INFO - PID 4965 | Cycle 1(1): loaded http://localhost:58743/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58743/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:37:21 INFO - PID 4965 | RSS: Main: 173232128 05:37:21 INFO - PID 4965 | 05:37:23 INFO - PID 4965 | Cycle 1(1): loaded http://localhost:58743/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58743/tests/kraken/driver.html?testName=ai-astar) 05:37:23 INFO - PID 4965 | RSS: Main: 174522368 05:37:23 INFO - PID 4965 | 05:37:23 INFO - PID 4965 | __start_tp_report 05:37:23 INFO - PID 4965 | _x_x_mozilla_page_load 05:37:23 INFO - PID 4965 | _x_x_mozilla_page_load_details 05:37:23 INFO - PID 4965 | |i|pagename|runs| 05:37:23 INFO - PID 4965 | |0;ai-astar;101;108;109;107;115;113;109;108;109;109 05:37:23 INFO - PID 4965 | |1;audio-beat-detection;153;122;144;169;126;152;160;123;164;122 05:37:23 INFO - PID 4965 | |2;audio-dft;164;162;163;167;164;168;163;164;166;172 05:37:23 INFO - PID 4965 | |3;audio-fft;75;75;76;158;75;75;75;74;97;74 05:37:23 INFO - PID 4965 | |4;audio-oscillator;82;82;131;82;82;82;129;82;82;129 05:37:23 INFO - PID 4965 | |5;imaging-gaussian-blur;114;113;113;114;113;114;113;113;114;114 05:37:23 INFO - PID 4965 | |6;imaging-darkroom;151;151;150;150;149;151;149;150;149;148 05:37:23 INFO - PID 4965 | |7;imaging-desaturate;96;96;94;95;94;94;95;94;94;94 05:37:23 INFO - PID 4965 | |8;json-parse-financial;54;58;54;53;54;55;55;56;53;55 05:37:23 INFO - PID 4965 | |9;json-stringify-tinderbox;53;53;53;53;53;54;54;53;53;53 05:37:23 INFO - PID 4965 | |10;stanford-crypto-aes;77;86;91;77;76;76;77;85;76;78 05:37:23 INFO - PID 4965 | |11;stanford-crypto-ccm;126;126;124;135;123;125;127;127;124;164 05:37:23 INFO - PID 4965 | |12;stanford-crypto-pbkdf2;194;196;189;199;190;187;186;183;189;183 05:37:23 INFO - PID 4965 | |13;stanford-crypto-sha256-iterative;73;68;70;70;72;67;67;71;69;72 05:37:23 INFO - PID 4965 | __end_tp_report 05:37:23 INFO - PID 4965 | __start_cc_report 05:37:23 INFO - PID 4965 | _x_x_mozilla_cycle_collect,934 05:37:23 INFO - PID 4965 | __end_cc_report 05:37:23 INFO - PID 4965 | __startTimestamp1498480643900__endTimestamp 05:37:23 INFO - PID 4965 | 05:37:23 INFO - PID 4965 | ------- Summary: start ------- 05:37:23 INFO - PID 4965 | Number of tests: 14 05:37:23 INFO - PID 4965 | 05:37:23 INFO - PID 4965 | [#0] ai-astar Cycles:10 Average:108.80 Median:109.00 stddev:3.68 (3.4%) stddev-sans-first:2.60 05:37:23 INFO - PID 4965 | Values: 101.0 108.0 109.0 107.0 115.0 113.0 109.0 108.0 109.0 109.0 05:37:23 INFO - PID 4965 | 05:37:23 INFO - PID 4965 | [#1] audio-beat-detection Cycles:10 Average:143.50 Median:152.50 stddev:18.73 (12.3%) stddev-sans-first:19.55 05:37:23 INFO - PID 4965 | Values: 153.0 122.0 144.0 169.0 126.0 152.0 160.0 123.0 164.0 122.0 05:37:23 INFO - PID 4965 | 05:37:23 INFO - PID 4965 | [#2] audio-dft Cycles:10 Average:165.30 Median:165.00 stddev:3.02 (1.8%) stddev-sans-first:3.17 05:37:23 INFO - PID 4965 | Values: 164.0 162.0 163.0 167.0 164.0 168.0 163.0 164.0 166.0 172.0 05:37:23 INFO - PID 4965 | 05:37:23 INFO - PID 4965 | [#3] audio-fft Cycles:10 Average:85.40 Median:75.00 stddev:26.45 (35.3%) stddev-sans-first:27.78 05:37:23 INFO - PID 4965 | Values: 75.0 75.0 76.0 158.0 75.0 75.0 75.0 74.0 97.0 74.0 05:37:23 INFO - PID 4965 | 05:37:23 INFO - PID 4965 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:82.00 stddev:23.03 (28.1%) stddev-sans-first:23.84 05:37:23 INFO - PID 4965 | Values: 82.0 82.0 131.0 82.0 82.0 82.0 129.0 82.0 82.0 129.0 05:37:23 INFO - PID 4965 | 05:37:23 INFO - PID 4965 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:114.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:37:23 INFO - PID 4965 | Values: 114.0 113.0 113.0 114.0 113.0 114.0 113.0 113.0 114.0 114.0 05:37:23 INFO - PID 4965 | 05:37:23 INFO - PID 4965 | [#6] imaging-darkroom Cycles:10 Average:149.80 Median:150.00 stddev:1.03 (0.7%) stddev-sans-first:1.00 05:37:23 INFO - PID 4965 | Values: 151.0 151.0 150.0 150.0 149.0 151.0 149.0 150.0 149.0 148.0 05:37:23 INFO - PID 4965 | 05:37:23 INFO - PID 4965 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:94.50 stddev:0.84 (0.9%) stddev-sans-first:0.73 05:37:23 INFO - PID 4965 | Values: 96.0 96.0 94.0 95.0 94.0 94.0 95.0 94.0 94.0 94.0 05:37:23 INFO - PID 4965 | 05:37:23 INFO - PID 4965 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:1.49 (2.7%) stddev-sans-first:1.56 05:37:23 INFO - PID 4965 | Values: 54.0 58.0 54.0 53.0 54.0 55.0 55.0 56.0 53.0 55.0 05:37:23 INFO - PID 4965 | 05:37:23 INFO - PID 4965 | [#9] json-stringify-tinderbox Cycles:10 Average:53.20 Median:53.00 stddev:0.42 (0.8%) stddev-sans-first:0.44 05:37:23 INFO - PID 4965 | Values: 53.0 53.0 53.0 53.0 53.0 54.0 54.0 53.0 53.0 53.0 05:37:23 INFO - PID 4965 | 05:37:23 INFO - PID 4965 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:77.50 stddev:5.38 (6.9%) stddev-sans-first:5.61 05:37:23 INFO - PID 4965 | Values: 77.0 86.0 91.0 77.0 76.0 76.0 77.0 85.0 76.0 78.0 05:37:23 INFO - PID 4965 | 05:37:23 INFO - PID 4965 | [#11] stanford-crypto-ccm Cycles:10 Average:130.10 Median:126.50 stddev:12.37 (9.8%) stddev-sans-first:13.03 05:37:23 INFO - PID 4965 | Values: 126.0 126.0 124.0 135.0 123.0 125.0 127.0 127.0 124.0 164.0 05:37:23 INFO - PID 4965 | 05:37:23 INFO - PID 4965 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.60 Median:189.50 stddev:5.34 (2.8%) stddev-sans-first:5.42 05:37:23 INFO - PID 4965 | Values: 194.0 196.0 189.0 199.0 190.0 187.0 186.0 183.0 189.0 183.0 05:37:23 INFO - PID 4965 | 05:37:23 INFO - PID 4965 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.50 stddev:2.13 (3.0%) stddev-sans-first:1.94 05:37:23 INFO - PID 4965 | Values: 73.0 68.0 70.0 70.0 72.0 67.0 67.0 71.0 69.0 72.0 05:37:23 INFO - PID 4965 | -------- Summary: end -------- 05:37:23 INFO - PID 4965 | 05:37:24 INFO - TEST-INFO | 4965: exit 0 05:37:24 INFO - TEST-OK | kraken | took 61327ms 05:37:24 INFO - SUITE-END | took 1177s 05:37:25 INFO - Completed test suite (00:19:37) 05:37:25 INFO - javascript benchmark 05:37:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8164.125941816037, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3113.5641010258582, 3149.4960806270988, 3152.700493453122, 3184.984075079625, 3188.995466428075, 6079.361667024965, 6093.086037094438, 6099.573029887904, 6126.02914498734, 6129.053167990504, 5974.6713930733795, 6096.725647345869, 6127.586602260213, 6131.0, 6141.324454310023, 5689.032864413039, 5691.0, 5742.425757424245, 5752.7986520471795, 5761.510271626917, 5714.828555143332, 5749.770009199627, 5796.8260952171295, 5798.536117110621, 5799.0, 5540.473655002768, 5608.55131589476, 5673.432656734335, 5679.630823996427, 5681.57388195887, 5522.0, 5561.221428999943, 5593.188987596775, 5614.578906582023, 5625.212470254168, 5598.076317407623, 5672.744726487318, 5684.744186511617, 5707.71461426927, 5719.14212868069, 6091.512678985715, 6118.755249790003, 6123.173371594822, 6131.41751533608, 6138.539609529304, 6605.896411162155, 6699.531032827704, 6702.162229721285, 6706.731730730765, 6718.49611279156, 6505.4795616350575, 6583.407493325576, 6641.86716265672, 6652.301508341603, 6686.699098540577, 6126.151269885628, 6157.84605384869, 6196.10156527301, 6197.163382943245, 6217.6891155442045, 6825.69284382204, 6847.1783385993, 6850.897236541456, 6853.0, 6869.656517174221, 6332.366763323723, 6435.646039467781, 6440.066190402459, 6444.162258906406, 6448.871022579616, 6503.0, 6540.117084193668, 6603.735850565923, 6626.304238054935, 6645.269020407752, 6632.502562307846, 6657.3342665733035, 6664.766733164413, 6675.365840245169, 6681.09805176295, 6452.580582262138, 6691.397774200345, 6715.026321183401, 6716.496262780311, 6720.260771315151, 5329.333833270841, 5345.919811202835, 5356.464353564613, 5422.484863937999, 5455.345358556999, 4572.702774319659, 4620.699654522446, 4635.976820115878, 4645.581897629229, 4659.44086709597, 5737.971310143423, 5750.971245143831, 5778.5377169826315, 5796.88406231873, 5842.415758424208, 6687.699053542505, 6721.630310332881, 6741.0, 6785.5250132490255, 6789.219239787488, 5681.57388195887, 5791.82624521265, 5821.650700957956, 5830.067189249785, 5844.532437404998, 5783.971080144656, 5801.303843538718, 5832.795852145155, 5877.764889404376, 5878.470937615635, 6338.556301058881, 6394.840128996812, 6445.774397896051, 6499.870002599827, 6522.412982831378, 6726.730930762715, 6730.394264516217, 6733.192016957996, 6733.6296503692765, 6735.562188457735, 6505.154329937078, 6508.023796430573, 6509.349065093453, 6516.989866570689, 6522.673866306761, 6400.039994000937, 6509.674516274073, 6529.020646903003, 6608.0, 6635.8009259722285, 6577.309382514958, 6589.670516474253, 6667.933320666925, 6671.132752742113, 6673.1324927761025, 6445.774397896051, 6490.902636460362, 6499.837504062436, 6502.284748677736, 6527.804165875032, 6429.7106630200815, 6493.026046093124, 6495.447886929664, 6533.738650453929, 6537.411632953057, 6222.751089956351, 6308.747650093945, 6328.114064030948, 6385.68071596409, 6428.067930150196, 6411.4870810336, 6472.255690595453, 6474.805755827333, 6487.870242595027, 6495.675216239264, 6321.96839015802, 6373.107764913008, 6385.265694445198, 6387.68061596909, 6417.454516365974], "value": 6059.351384264533, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [797.9760607181787, 830.9709160179395, 849.6006876767918, 880.0231742765529, 880.0978996528557, 39429.60570394295, 39933.40099898504, 40095.0, 40241.99395015123, 40243.396349054754, 36401.45397819028, 36579.45130823033, 36895.70865019725, 37075.25849483009, 37095.0, 6880.7591734289435, 6941.2017617973825, 7025.086738723959, 7026.367626913577, 7035.1557813062245, 6901.309869013109, 7032.296770322952, 7036.612986285778, 7046.964765176167, 7059.294070592951, 7014.403775679073, 7022.192447868484, 7033.753818616349, 7042.366187043165, 7048.0, 6980.162380514345, 7016.36852683261, 7019.333163349474, 7021.648917554102, 7031.085958825345, 6363.87272254557, 6377.776777812801, 6430.1319321891415, 6435.967820160869, 6441.0, 32931.50602740937, 32992.17519562006, 32993.50509742356, 33045.0, 33188.33623327544, 3388.0344101931078, 3434.5706786651667, 3434.639362866913, 3439.724822014258, 3589.6589823966942, 30411.087667370015, 30547.694523054706, 30570.0, 30641.233969150726, 30647.846760766275, 3746.7939263340504, 3782.5082739244, 3795.886123416302, 3796.4305354196817, 3823.445600387956, 184975.0, 185441.0, 185492.0, 186877.0656146724, 187592.0, 42853.35719964203, 47258.0, 48167.51832481701, 48209.0, 48348.0, 49760.0, 50068.24897626466, 50077.74961125244, 50089.24866127011, 50165.0, 15592.766108508382, 15671.764923526156, 15695.68608627821, 15702.68594628101, 15734.291956861969, 12877.4205160768, 12904.290264035568, 12909.870901291055, 12970.935145324402, 13001.284929328978, 13700.65748356279, 13703.588892333246, 13713.108647937852, 13813.723725525433, 13962.301884905917, 5427.1316589345515, 5485.6434331768305, 5493.258410114663, 5575.4424557543925, 5636.126400407943, 1003.2375394700081, 1022.1209759606733, 1023.125227930124, 1047.3349423116224, 1063.4629512096496, 22970.0, 23087.653685194735, 23132.53734925292, 23346.2996110117, 23645.881770591383, 1089.9237053406187, 1090.5637744902103, 1139.7834411461795, 1143.6340371081174, 1146.587228597704, 11940.44774179351, 12875.0, 12908.096433249582, 12967.640684552574, 12977.171734338393, 229236.0, 236276.0, 239604.0, 240007.0, 242014.0, 57277.713611431675, 58368.0, 58577.41422585805, 58675.41324586785, 58910.0, 1510.9622259443381, 1511.4860947277978, 1517.6627992890824, 1524.6264665156887, 1527.5646440764328, 26647.86676066607, 28679.713202867704, 28882.855585721936, 28994.260344379403, 29061.273468163465, 49811.0, 50556.0, 50706.74646626743, 50984.49015509798, 50988.23517647312, 195440.0, 197562.0, 197982.0, 198278.0, 198511.0, 31755.523667145473, 31794.68205317917, 31943.840280798446, 32020.83989580037, 35713.0, 37406.251874962894, 42324.36513452239, 42950.570494294654, 43089.0, 43628.0, 30299.697003029687, 30510.542341865334, 30676.23309417193, 31582.210444739067, 32506.51240231351, 25273.62089568621, 26289.21132366032, 26335.473290534464, 26514.337141571614, 26546.60180097339, 33694.3261134771, 33720.83139584286, 33867.98396048122, 34711.30577388489, 34753.65246347605, 28576.57135142933, 30168.698313017467, 30202.697973020866, 30377.240568985068, 31042.0, 23162.0, 23710.288691339287, 24512.0, 24531.14141005056, 24612.261632151065], "value": 16671.176108028292, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [529.5472371122693, 530.358266497538, 538.2760187547749, 575.2694078520278, 593.2554643921877, 21592.568148637038, 22382.21662241822, 22400.439989000242, 22432.990515426805, 22458.663120053214, 23517.647235291483, 24369.512609747795, 25493.87253063732, 25594.232173034794, 25770.87114564429, 6231.626102433857, 6324.367563243685, 6331.2085989251345, 6331.77838775643, 6376.808695739135, 6304.968475157618, 6313.936860631381, 6352.396522330371, 6364.649944253064, 6409.743610255584, 5889.146073819294, 6197.938020619781, 6299.590526615778, 6334.746610135589, 6342.619442833422, 6234.657093859859, 6240.6879656017245, 6258.249010118792, 6289.779857705004, 6296.779612713579, 5822.854428639275, 5877.235959325303, 5887.8233652990475, 5889.087191485284, 5898.616589921641, 27196.864015679796, 27920.30199245015, 28280.010199642915, 28320.716792832012, 28371.716282837115, 1850.0, 1897.8197071278207, 1916.1377380178976, 1918.3094086129122, 1919.395390452003, 18208.63582728338, 18523.62952740951, 18635.347762828234, 18689.06554672261, 18797.342093026815, 2268.274152271274, 2321.141177764221, 2342.7071616047992, 2368.857868527894, 2370.8340416170877, 120854.3957280208, 124720.37639811833, 124733.0, 125568.37215813954, 126259.3687031559, 13953.860461395256, 14601.19693416851, 15126.848731512764, 15131.54605361841, 15178.392864285526, 23248.767512324997, 23266.65100023501, 23505.7649423507, 23543.88228058849, 23563.0574777007, 9998.700038998843, 10117.140043096271, 10189.133923616428, 10305.690829275134, 10429.322094063862, 9265.44407335562, 9313.627454901864, 9392.718218453458, 9509.90490095104, 9521.952390238004, 8877.091425343582, 9001.0, 9002.459852408876, 9172.770680733034, 9282.211012063915, 2676.5717485202276, 2694.178275625953, 2764.3918337966015, 2765.5436852919042, 2932.3402234497066, 930.3208657679932, 961.9374740641836, 972.8832540095234, 978.5449765858909, 1001.6944831826218, 23213.88393058024, 24709.135180268604, 25761.0, 25865.48269034609, 25905.35236619062, 1022.504085518523, 1042.6611351310855, 1044.2637940252105, 1050.495762034228, 1052.2686732720838, 11374.090072794157, 11439.0, 11510.079193664487, 11510.884891150981, 11604.071674266039, 494874.0, 510502.0, 511821.0, 514957.0, 516157.0, 100792.0, 106378.0, 106874.46562767136, 107696.4615176919, 109407.0, 1205.825155352469, 1228.9631311060682, 1255.6233130060946, 1260.9306488143056, 1261.779188641984, 18604.25582976666, 20992.370228893156, 21122.788772112082, 21207.257745978815, 21366.0, 48890.75554622347, 51831.222531661304, 52280.73859630677, 52290.738546307024, 53218.2017269749, 65515.0, 66554.66722666356, 66568.66715666391, 66786.0, 66876.0, 12532.122751407314, 12874.905633021299, 12907.935460322638, 12960.805587916377, 12982.415791289604, 17735.645287094445, 18629.44111676652, 18672.626547468702, 18763.71854422212, 18856.434306970812, 15091.169985650895, 15103.924480377527, 15295.694086118438, 15556.533304000897, 15704.371825126867, 13274.535391261259, 13445.260510672008, 14065.929670351583, 14420.062695924731, 14488.058276212434, 14988.0, 15076.698466030837, 15213.0, 15800.60498487547, 16157.919210403872, 12841.101122921305, 12921.547745828851, 12935.547255846, 12968.0, 12992.545260915822, 15256.313465894284, 15296.923515382352, 15349.0, 15364.0, 15399.692006160038], "value": 11487.599855661814, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1379.772337564302, 1448.7175000874834, 1449.4492093004656, 1453.505808025271, 1464.4142343062774, 13277.535286264983, 13866.514671986482, 13870.791938120923, 13915.930420347897, 13927.303634818269, 13346.53287134948, 13730.58808235752, 13735.862641373607, 13744.381502832372, 13750.724985500285, 2574.1119313836743, 2582.044643481905, 2611.086119858044, 2611.2949503634104, 2622.5672763993916, 2536.6321883326905, 2589.779868711152, 2591.06721580231, 2598.350412396901, 2599.1812579037637, 2428.1258746851117, 2447.853128812268, 2463.224084413404, 2464.728879823218, 2484.0312278211513, 2507.3104896153613, 2608.400067984365, 2616.699079605851, 2622.10848311575, 2622.5803871380676, 2440.9389765255833, 2463.6550882876413, 2472.925812225636, 2477.2072936660275, 2486.651868738378, 13212.86787132126, 13364.665883352896, 13475.19148851072, 13486.39311230997, 13543.255120968342, 7099.077119974422, 7324.743633972786, 7371.189169191384, 7401.555906645618, 7410.147832999221, 4125.64931980782, 4239.957600423987, 4345.847895323648, 4354.368616550582, 4393.494748103945, 1599.3202888772225, 1621.0759866875885, 1630.7064728348892, 1650.2243945345788, 1689.754985527104, 20831.5833683327, 20946.476338091517, 21093.15627374903, 21151.788482115135, 21159.0, 5929.792457263975, 5938.8218353449465, 5979.1629171915965, 6126.632402055891, 6173.0, 14046.648833779032, 14104.71790564183, 14110.647233819236, 14121.0, 14148.858511414754, 7034.19106802714, 7249.8550028999125, 7268.309510596485, 7272.127344718562, 7308.890366644505, 6722.9663851680425, 6726.159230096238, 6768.052472653832, 6824.351686589766, 6841.897371539431, 5009.774560144802, 5022.698638081727, 5043.9747801260755, 5072.67027643202, 5153.1497302945345, 1463.0928824129107, 1465.5310300703673, 1473.8378778334375, 1484.3913995261892, 1502.6243439140214, 868.2793281576277, 876.9429987050821, 889.6308032166578, 896.8430524658158, 914.9222316103072, 6876.243613202544, 6992.0, 7153.96423017892, 7288.3076107769675, 7567.508111972704, 713.8643657705123, 729.2634439216324, 731.1701219116235, 732.7105793211651, 735.1692587376338, 4416.403785488982, 4970.850874473772, 5009.799608015638, 5190.455002224788, 5277.551408130275, 16709.498715038568, 16774.83225167757, 17253.482395528154, 17391.826081739273, 17429.564260893578, 16371.0, 16758.0, 17098.743518847226, 17170.742438863428, 17610.295588176585, 9703.757406065046, 9943.30396872212, 10034.799304014025, 10081.69754907354, 10088.092071713434, 7498.962505187439, 7658.119316278699, 7677.193894640982, 7820.45256832039, 7982.281594656509, 14518.491852785102, 15047.774283385977, 15080.849191507945, 15340.76988845146, 15344.616384590474, 15239.847601523843, 15673.137977411352, 15765.054096754231, 15797.131157786433, 16291.837081629032, 9866.950665246628, 10014.349067310894, 10025.097741203326, 10029.69910902674, 10071.143952763805, 11768.882311177122, 12267.202631828903, 12349.135560510678, 12421.689457763629, 12447.502099915902, 9770.609175632895, 9976.15202707778, 10161.593536258466, 10385.324953877975, 10456.0, 9520.428774273565, 9732.464714440774, 10059.547320370748, 10072.899271007196, 10190.082892539707, 9351.53242337894, 9399.671011514563, 9463.621455141718, 9470.95264523673, 9510.572024259063, 6601.900971485527, 6619.669016549057, 6690.962900750392, 6694.397504224643, 6969.477289203432, 7052.153741551047, 7054.823629409306, 7088.503804733826, 7306.123265208209, 7340.1191856975365], "value": 5976.570483795016, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [476.2094922428769, 485.9854204373869, 494.45115921327323, 495.16070260907776, 521.8173639226269, 6192.566520343577, 6226.346233645464, 6260.154879091321, 6271.090691849679, 6280.968595157018, 5926.822195334136, 6031.577789554733, 6078.939210607892, 6088.330283668793, 6096.439495411926, 4971.179755340365, 4977.153883839738, 4995.100881841267, 4995.425526064513, 5011.942714943882, 5006.499350065001, 5010.574101201402, 5012.799488020475, 5014.548690617844, 5018.34761481007, 4766.118268120392, 4953.306537084811, 4972.129877271481, 4977.452480227172, 4990.27640992056, 4922.26166075088, 4949.653524253304, 4959.330490383806, 4959.454460009396, 4989.226669866177, 4413.44831896013, 4429.512753597134, 4429.867103986886, 4460.576245256695, 4473.015936493966, 5985.426266705315, 5990.2212712347555, 6018.638881667114, 6035.111559636708, 6044.153818465418, 5693.28833895763, 5699.0, 5701.543876489913, 5707.5148612368, 5713.542916566665, 6510.3489651034515, 6552.93447065528, 6560.704768285391, 6563.146790917198, 6563.146790917198, 4839.685420447659, 4876.707397556158, 4895.363602731658, 4906.31311616374, 4928.359313289286, 6927.515073944826, 6928.757493487754, 6937.161652162181, 6997.670442615887, 7002.894956575656, 5031.7987280509105, 5050.964552266776, 5054.620903432257, 5058.544730974157, 5059.595232381401, 5127.3847138343635, 5129.692218466904, 5133.948660513347, 5135.0, 5141.5886729061585, 5651.971740141273, 5697.373288938214, 5703.20155178267, 5740.885182296331, 5781.860711536674, 6615.735370585219, 6619.933800662028, 6639.767608133789, 6642.0, 6667.63328016954, 1648.7279598866292, 1766.5318690547015, 1777.9288828446977, 1779.7241427578488, 1789.7650621071418, 1131.7679875625477, 1203.3080978437433, 1222.54765736678, 1236.1841184818156, 1245.0848626259692, 5528.917066244009, 5646.153077038477, 5646.463585959327, 5651.463111004448, 5699.943000570024, 6728.629925354153, 6745.898811517831, 6762.83092922671, 6776.559523631046, 6807.434290113202, 5753.942460575425, 5771.451712087345, 5785.595008349459, 5801.6809075500405, 5826.1552074948895, 3550.1479644885558, 3575.1598374382, 3588.318219538279, 3597.5143355647174, 3607.8196090195383, 6541.182352205974, 6545.345465453416, 6561.40947314744, 6562.737490500422, 6563.0, 6883.242843287235, 6903.965480172567, 6904.654767261617, 6922.446204303644, 6942.132233470817, 6549.377809108127, 6576.514447342916, 6577.539572229898, 6594.7032383542855, 6596.670166491752, 6664.966675166593, 6733.494987876027, 6758.560693554903, 6774.86450270982, 6793.898091528532, 6644.667766611747, 6673.9332606673315, 6675.933240667531, 6720.899186512304, 6732.865342693217, 6291.370862913672, 6539.182602174728, 6557.737690492327, 6590.5716128451495, 6594.571352862049, 5477.370102438271, 5481.972590137024, 5492.313460817398, 5494.560435165097, 5499.890002199853, 6752.324767523209, 6766.255711871789, 6766.428757072281, 6768.898466522907, 6809.795706128824, 6442.935570644234, 6529.943067933586, 6559.114519539801, 6561.606303621798, 6577.2436169841085, 6467.385598368336, 6549.803505894831, 6570.178727659043, 6579.960212334192, 6595.340465953366, 6474.870502590016, 6477.8704425912165, 6501.4798816095545, 6523.804285871432, 6524.934750652433, 6544.181977252843, 6561.96719016421, 6605.0, 6609.834754131185, 6625.503087268377, 6420.55056146084, 6422.775202867877, 6440.742370305135, 6445.775302692474, 6455.7740479083], "value": 5073.371408642118, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [808.179697606929, 813.0771574263212, 815.604431850552, 840.3865178419753, 851.9531425771584, 17126.143692815356, 17628.030458324803, 17672.293108275684, 17676.292948282084, 17698.734518982208, 15750.606234844134, 15870.52388428346, 17627.91186044068, 18404.0, 20351.084201210942, 1035.735887348725, 1036.7563622548696, 1046.3512622174262, 1050.5535147562293, 1051.8895515970828, 1053.836655318423, 1054.7574057966672, 1055.9366438013706, 1056.7675111475462, 1056.973575660607, 1122.0406552397706, 1124.42092322454, 1124.6794663520898, 1125.0886781706802, 1127.9436028198597, 1030.7320096774818, 1058.640062378795, 1072.951717172729, 1117.474786850179, 1122.1752012271015, 785.344237561631, 788.7751990682627, 789.4276649429117, 791.2878409431501, 791.6041979010495, 18363.63272734538, 18368.816311836978, 18440.17019234138, 18455.630887382176, 18604.16281267346, 18583.349582764673, 19396.0, 19415.029248537518, 19548.120334584837, 19585.510362240915, 14660.486882959045, 15070.171140587263, 15181.013234139746, 15192.848071519255, 15276.465323713617, 3344.1973926257765, 3378.239896023375, 3378.560787097686, 3379.053864917827, 3379.273456206927, 95910.0, 98393.50803245937, 102862.48568757183, 104694.0, 106651.46674266657, 14120.0, 14447.927760361132, 14458.0, 14576.927115364568, 14643.56069317922, 24452.0, 26001.479970400487, 26162.73837261603, 26220.73779262221, 26500.204993850217, 7545.170031296553, 7647.885281720779, 7700.19147989453, 7718.421118416029, 7721.459497835098, 3716.6655001050035, 3719.590845007047, 3744.1762812181278, 3754.0427191066105, 3758.9436158457647, 4765.475797662254, 4852.854414367504, 4888.755562221946, 4920.803167873317, 4925.75371231437, 1020.5713600287897, 1058.8941105889503, 1061.7982583309147, 1062.8830828608848, 1068.3750006246432, 673.2426020726682, 673.9797806065826, 676.539952832069, 704.0425021970117, 708.2457183099982, 11524.250923689933, 11626.65120046383, 11902.761944761056, 12441.688957776129, 13374.866251337557, 674.1438373265925, 707.5719189890145, 708.1431467923767, 708.5075872268827, 714.6569646569676, 5173.405058418255, 5212.765425555784, 5336.199570064521, 5472.34331880169, 5611.270534830446, 95126.0, 99220.50389748006, 99419.0, 101895.0, 102735.0, 64272.0, 85585.57207213924, 86519.0, 89172.5541372289, 90572.09427905768, 68370.65814670894, 74799.25200747923, 76760.0, 77144.22855771483, 78464.0, 11057.447127643747, 11061.502232399722, 11371.886281137082, 11380.94309528447, 11762.411879405825, 31012.22469438192, 33168.66831331656, 33533.32933341271, 33765.49351759676, 34155.65844341624, 41764.373534397615, 42011.7899410501, 43518.34722479102, 44303.778481108675, 44984.550154499346, 15468.226588670746, 16228.594285142966, 16361.918190409448, 16476.258568364214, 16488.0931548766, 17431.0, 17733.20200591002, 17809.554761131076, 18730.812691872907, 18757.437276881716, 15276.694466110837, 15314.46399376061, 15897.205139743199, 16199.67600648004, 16370.345186192419, 16222.0, 16768.35512371708, 18116.637667246843, 18197.909010455394, 18240.087995600432, 16262.430814921421, 16757.664846702755, 16767.580810479347, 16771.66456670884, 16954.406595769087, 12430.0, 13042.608721738363, 13791.310434478437, 13867.861321386657, 13914.860851391357, 12275.263484190977, 12364.938175309066, 12371.257724536557, 12706.555270565486, 12991.870081299066], "value": 8415.144274163258, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1534.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 108.0, 109.0, 107.0, 115.0, 113.0, 109.0, 108.0, 109.0, 109.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 122.0, 144.0, 169.0, 126.0, 152.0, 160.0, 123.0, 164.0, 122.0], "value": 143.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 163.0, 167.0, 164.0, 168.0, 163.0, 164.0, 166.0, 172.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 158.0, 75.0, 75.0, 75.0, 74.0, 97.0, 74.0], "value": 85.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 131.0, 82.0, 82.0, 82.0, 129.0, 82.0, 82.0, 129.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 114.0, 113.0, 114.0, 113.0, 113.0, 114.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 150.0, 150.0, 149.0, 151.0, 149.0, 150.0, 149.0, 148.0], "value": 149.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 58.0, 54.0, 53.0, 54.0, 55.0, 55.0, 56.0, 53.0, 55.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 53.0, 53.0, 54.0, 54.0, 53.0, 53.0, 53.0], "value": 53.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 86.0, 91.0, 77.0, 76.0, 76.0, 77.0, 85.0, 76.0, 78.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 126.0, 124.0, 135.0, 123.0, 125.0, 127.0, 127.0, 124.0, 164.0], "value": 130.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 196.0, 189.0, 199.0, 190.0, 187.0, 186.0, 183.0, 189.0, 183.0], "value": 189.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 68.0, 70.0, 70.0, 72.0, 67.0, 67.0, 71.0, 69.0, 72.0], "value": 69.9, "unit": "score"}]}]} 05:37:25 INFO - Return code: 0 05:37:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:37:25 INFO - # TBPL SUCCESS # 05:37:25 INFO - Running post-action listener: _resource_record_post_action 05:37:25 INFO - [mozharness: 2017-06-26 12:37:25.257571Z] Finished run-tests step (success) 05:37:25 INFO - Running post-run listener: _resource_record_post_run 05:37:25 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 434868224; Read time: 12; Write time: 305244 05:37:25 INFO - TinderboxPrint: CPU usage
13.1% 05:37:25 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:37:25 INFO - TinderboxPrint: I/O write bytes / time
434,868,224 / 305,244 05:37:25 INFO - TinderboxPrint: CPU idle
8,290.4 (86.9%) 05:37:25 INFO - TinderboxPrint: CPU user
1,203.0 (12.6%) 05:37:25 INFO - TinderboxPrint: Swap in / out
0 / 0 05:37:25 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 105295872; Read time: 0; Write time: 91568 05:37:25 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:37:25 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 329572352; Read time: 0; Write time: 213676 05:37:25 INFO - Running post-run listener: _upload_blobber_files 05:37:25 INFO - Blob upload gear active. 05:37:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:37:25 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:37:25 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:37:25 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:37:26 INFO - (blobuploader) - INFO - Open directory for files ... 05:37:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:37:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:37:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:27 INFO - (blobuploader) - INFO - Done attempting. 05:37:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:37:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:37:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:31 INFO - (blobuploader) - INFO - Done attempting. 05:37:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:37:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:32 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:37:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:32 INFO - (blobuploader) - INFO - Done attempting. 05:37:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:37:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:37:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:32 INFO - (blobuploader) - INFO - Done attempting. 05:37:32 INFO - (blobuploader) - INFO - Iteration through files over. 05:37:32 INFO - Return code: 0 05:37:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:37:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:37:32 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6f0cabfae788e507f714942788af4c070c0d9697fb507173e3912a19e481b7dc0b6b4ec5ffad42fbffa4e61d246c6ee5012375dae782caf6875b59fa01d28b89", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6182f145835ce7b637e7471ec6198301399ad76a16c9b7685279acfc3e5f75d81bd457d7c633c44df7790be0f92799a560326d441fe3412971d3042af34cb94f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8686a94fb0c4fa6119d4032257e2fb0b329d19b773b68a72e21faa3b785e688664e02dea1270ef840bf06068be7320963f552e941adc74b15a2e22913140b1b4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e3693f3e5b4d6531618d8b83f74a23589db0b704ed708e42d8cb9ca43ea088fc339710d99ad441793b92a36732fa4513b0ae071bc73647578cdf1a04cc989a2"} 05:37:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:37:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:37:32 INFO - Contents: 05:37:32 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6f0cabfae788e507f714942788af4c070c0d9697fb507173e3912a19e481b7dc0b6b4ec5ffad42fbffa4e61d246c6ee5012375dae782caf6875b59fa01d28b89", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6182f145835ce7b637e7471ec6198301399ad76a16c9b7685279acfc3e5f75d81bd457d7c633c44df7790be0f92799a560326d441fe3412971d3042af34cb94f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8686a94fb0c4fa6119d4032257e2fb0b329d19b773b68a72e21faa3b785e688664e02dea1270ef840bf06068be7320963f552e941adc74b15a2e22913140b1b4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e3693f3e5b4d6531618d8b83f74a23589db0b704ed708e42d8cb9ca43ea088fc339710d99ad441793b92a36732fa4513b0ae071bc73647578cdf1a04cc989a2"} 05:37:32 INFO - Running post-run listener: copy_logs_to_upload_dir 05:37:32 INFO - Copying logs to upload dir... 05:37:32 INFO - mkdir: /builds/slave/test/build/upload/logs 05:37:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.900547 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-06-26 05:37:31.851242) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-26 05:37:31.858934) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1498479395.904927-1339089345 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/6f0cabfae788e507f714942788af4c070c0d9697fb507173e3912a19e481b7dc0b6b4ec5ffad42fbffa4e61d246c6ee5012375dae782caf6875b59fa01d28b89", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6182f145835ce7b637e7471ec6198301399ad76a16c9b7685279acfc3e5f75d81bd457d7c633c44df7790be0f92799a560326d441fe3412971d3042af34cb94f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8686a94fb0c4fa6119d4032257e2fb0b329d19b773b68a72e21faa3b785e688664e02dea1270ef840bf06068be7320963f552e941adc74b15a2e22913140b1b4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e3693f3e5b4d6531618d8b83f74a23589db0b704ed708e42d8cb9ca43ea088fc339710d99ad441793b92a36732fa4513b0ae071bc73647578cdf1a04cc989a2"} build_url:https://queue.taskcluster.net/v1/task/VWKTNCDOTqGeauhoZVS7QQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011355 build_url: 'https://queue.taskcluster.net/v1/task/VWKTNCDOTqGeauhoZVS7QQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6f0cabfae788e507f714942788af4c070c0d9697fb507173e3912a19e481b7dc0b6b4ec5ffad42fbffa4e61d246c6ee5012375dae782caf6875b59fa01d28b89", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6182f145835ce7b637e7471ec6198301399ad76a16c9b7685279acfc3e5f75d81bd457d7c633c44df7790be0f92799a560326d441fe3412971d3042af34cb94f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8686a94fb0c4fa6119d4032257e2fb0b329d19b773b68a72e21faa3b785e688664e02dea1270ef840bf06068be7320963f552e941adc74b15a2e22913140b1b4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e3693f3e5b4d6531618d8b83f74a23589db0b704ed708e42d8cb9ca43ea088fc339710d99ad441793b92a36732fa4513b0ae071bc73647578cdf1a04cc989a2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-26 05:37:31.885606) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-26 05:37:31.885924) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1498479395.904927-1339089345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-26 05:37:31.967144) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-26 05:37:31.967454) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-26 05:37:31.970736) ========= ========= Total master_lag: 0.18 =========