builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-023 starttime: 1496487049.32 results: success (0) revision: 43039280fe464869428f03b047bb7c762784f44b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-03 03:50:49.321494) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-03 03:50:49.321939) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-03 03:50:49.322211) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-03 03:50:49.341061) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-03 03:50:49.341330) ========= 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=6d15e502d8e29d5d2676d664000001c3-1496481317.185838-1999502738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-03 03:50:51-- 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% 22.3M=0.001s 2017-06-03 03:50:51 (22.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128091 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-03 03:50:49.482115) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-03 03:50:49.482395) ========= 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=6d15e502d8e29d5d2676d664000001c3-1496481317.185838-1999502738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014641 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-03 03:50:49.534477) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-03 03:50:49.537824) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 43039280fe464869428f03b047bb7c762784f44b --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 43039280fe464869428f03b047bb7c762784f44b --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=6d15e502d8e29d5d2676d664000001c3-1496481317.185838-1999502738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-03 03:50:51,244 truncating revision to first 12 chars 2017-06-03 03:50:51,244 Setting DEBUG logging. 2017-06-03 03:50:51,244 attempt 1/10 2017-06-03 03:50:51,244 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/43039280fe46?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-03 03:50:51,710 unpacking tar archive at: mozilla-central-43039280fe46/testing/mozharness/ program finished with exit code 0 elapsedTime=0.768335 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-03 03:50:50.318231) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-03 03:50:50.318537) ========= script_repo_revision: 43039280fe464869428f03b047bb7c762784f44b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-03 03:50:50.321942) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-03 03:50:50.322210) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-03 03:50:50.352249) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 47 secs) (at 2017-06-03 03:50:50.352530) ========= /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=6d15e502d8e29d5d2676d664000001c3-1496481317.185838-1999502738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:50:52 INFO - MultiFileLogger online at 20170603 03:50:52 in /builds/slave/test 03:50:52 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 03:50:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:50:52 INFO - {'append_to_log': False, 03:50:52 INFO - 'base_work_dir': '/builds/slave/test', 03:50:52 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:50:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:50:52 INFO - 'branch': 'Firefox-Non-PGO', 03:50:52 INFO - 'buildbot_json_path': 'buildprops.json', 03:50:52 INFO - 'config_files': ('talos/linux_config.py',), 03:50:52 INFO - 'default_actions': ('clobber', 03:50:52 INFO - 'read-buildbot-config', 03:50:52 INFO - 'download-and-extract', 03:50:52 INFO - 'populate-webroot', 03:50:52 INFO - 'create-virtualenv', 03:50:52 INFO - 'install', 03:50:52 INFO - 'setup-mitmproxy', 03:50:52 INFO - 'run-tests'), 03:50:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:50:52 INFO - 'download_minidump_stackwalk': True, 03:50:52 INFO - 'download_symbols': 'ondemand', 03:50:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:50:52 INFO - 'tooltool.py': '/tools/tooltool.py', 03:50:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:50:52 INFO - '/tools/misc-python/virtualenv.py')}, 03:50:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:50:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:50:52 INFO - 'gecko_profile': False, 03:50:52 INFO - 'gecko_profile_interval': 0, 03:50:52 INFO - 'installer_path': 'installer.exe', 03:50:52 INFO - 'log_level': 'info', 03:50:52 INFO - 'log_name': 'talos', 03:50:52 INFO - 'log_to_console': True, 03:50:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:50:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:50:52 INFO - 'opt_config_files': (), 03:50:52 INFO - 'pip_index': False, 03:50:52 INFO - 'suite': 'dromaeojs-e10s', 03:50:52 INFO - 'system_bits': '32', 03:50:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:50:52 INFO - 'title': 'talos-linux64-ix-023', 03:50:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:50:52 INFO - 'use_talos_json': True, 03:50:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:50:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:50:52 INFO - 'work_dir': 'build'} 03:50:52 INFO - [mozharness: 2017-06-03 10:50:52.170041Z] Running clobber step. 03:50:52 INFO - Running pre-action listener: _resource_record_pre_action 03:50:52 INFO - Running main action method: clobber 03:50:52 INFO - rmtree: /builds/slave/test/build 03:50:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:50:53 INFO - Running post-action listener: _resource_record_post_action 03:50:53 INFO - [mozharness: 2017-06-03 10:50:53.725140Z] Finished clobber step (success) 03:50:53 INFO - [mozharness: 2017-06-03 10:50:53.725241Z] Running read-buildbot-config step. 03:50:53 INFO - Running pre-action listener: _resource_record_pre_action 03:50:53 INFO - Running main action method: read_buildbot_config 03:50:53 INFO - Using buildbot properties: 03:50:53 INFO - { 03:50:53 INFO - "project": "", 03:50:53 INFO - "product": "firefox", 03:50:53 INFO - "who": "nobody@mozilla.org", 03:50:53 INFO - "installer_path": "public/build/target.tar.bz2", 03:50:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:50:53 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:50:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:50:53 INFO - "stage_platform": "linux64", 03:50:53 INFO - "basedir": "/builds/slave/test", 03:50:53 INFO - "buildnumber": 887, 03:50:53 INFO - "platform": "ubuntu64_hw", 03:50:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:50:53 INFO - "slavebuilddir": "test", 03:50:53 INFO - "taskId": "Pb39DEDkTKOeFFFctpY0Yw", 03:50:53 INFO - "branch": "mozilla-central", 03:50:53 INFO - "script_repo_revision": "production", 03:50:53 INFO - "revision": "43039280fe464869428f03b047bb7c762784f44b", 03:50:53 INFO - "slavename": "talos-linux64-ix-023", 03:50:53 INFO - "repo_path": "mozilla-central" 03:50:53 INFO - } 03:50:53 INFO - Finding installer, test and symbols from parent task. 03:50:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pb39DEDkTKOeFFFctpY0Yw'}, attempt #1 03:50:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pb39DEDkTKOeFFFctpY0Yw'}, attempt #1 03:50:54 INFO - Task dependencies: Z6aQOLT8QLqJ2pnGOASq7Q 03:50:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z6aQOLT8QLqJ2pnGOASq7Q'}, attempt #1 03:50:55 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Z6aQOLT8QLqJ2pnGOASq7Q/artifacts/public/build/target.tar.bz2 03:50:55 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Z6aQOLT8QLqJ2pnGOASq7Q/artifacts/public/build/test_packages.json 03:50:55 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Z6aQOLT8QLqJ2pnGOASq7Q/artifacts/public/build/target.crashreporter-symbols.zip 03:50:55 INFO - Running post-action listener: _resource_record_post_action 03:50:55 INFO - [mozharness: 2017-06-03 10:50:55.092931Z] Finished read-buildbot-config step (success) 03:50:55 INFO - [mozharness: 2017-06-03 10:50:55.093151Z] Running download-and-extract step. 03:50:55 INFO - Running pre-action listener: _resource_record_pre_action 03:50:55 INFO - Running main action method: download_and_extract 03:50:55 INFO - mkdir: /builds/slave/test/build/tests 03:50:55 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')]} 03:50:55 INFO - trying https://queue.taskcluster.net/v1/task/Z6aQOLT8QLqJ2pnGOASq7Q/artifacts/public/build/target.test_packages.json 03:50:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Z6aQOLT8QLqJ2pnGOASq7Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:50:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z6aQOLT8QLqJ2pnGOASq7Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:50:55 INFO - Downloaded 989 bytes. 03:50:55 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:50:55 INFO - Using the following test package requirements: 03:50:55 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:50:55 INFO - u'common': [u'target.common.tests.zip'], 03:50:55 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:50:55 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:50:55 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:50:55 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:50:55 INFO - u'mozbase': [u'target.common.tests.zip'], 03:50:55 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:50:55 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:50:55 INFO - u'web-platform': [u'target.common.tests.zip', 03:50:55 INFO - u'target.web-platform.tests.tar.gz'], 03:50:55 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:50:55 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:50:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z6aQOLT8QLqJ2pnGOASq7Q/artifacts/public/build/target.common.tests.zip 03:50:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z6aQOLT8QLqJ2pnGOASq7Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:50:55 INFO - Fetch https://queue.taskcluster.net/v1/task/Z6aQOLT8QLqJ2pnGOASq7Q/artifacts/public/build/target.common.tests.zip into memory 03:50:57 INFO - Content-Length response header: 65722565 03:50:57 INFO - Bytes received: 65722565 03:51:08 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:51:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z6aQOLT8QLqJ2pnGOASq7Q/artifacts/public/build/target.common.tests.zip 03:51:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z6aQOLT8QLqJ2pnGOASq7Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:51:08 INFO - Fetch https://queue.taskcluster.net/v1/task/Z6aQOLT8QLqJ2pnGOASq7Q/artifacts/public/build/target.common.tests.zip into memory 03:51:09 INFO - Content-Length response header: 65722565 03:51:09 INFO - Bytes received: 65722565 03:51:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z6aQOLT8QLqJ2pnGOASq7Q/artifacts/public/build/target.talos.tests.zip 03:51:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z6aQOLT8QLqJ2pnGOASq7Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:51:21 INFO - Fetch https://queue.taskcluster.net/v1/task/Z6aQOLT8QLqJ2pnGOASq7Q/artifacts/public/build/target.talos.tests.zip into memory 03:51:22 INFO - Content-Length response header: 14447425 03:51:22 INFO - Bytes received: 14447425 03:51:22 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')]} 03:51:22 INFO - trying https://queue.taskcluster.net/v1/task/Z6aQOLT8QLqJ2pnGOASq7Q/artifacts/public/build/target.tar.bz2 03:51:22 INFO - Downloading https://queue.taskcluster.net/v1/task/Z6aQOLT8QLqJ2pnGOASq7Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:51:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z6aQOLT8QLqJ2pnGOASq7Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:51:24 INFO - Downloaded 59762544 bytes. 03:51:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z6aQOLT8QLqJ2pnGOASq7Q/artifacts/public/build/target.tar.bz2 03:51:24 INFO - mkdir: /builds/slave/test/properties 03:51:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:51:24 INFO - Writing to file /builds/slave/test/properties/build_url 03:51:24 INFO - Contents: 03:51:24 INFO - build_url:https://queue.taskcluster.net/v1/task/Z6aQOLT8QLqJ2pnGOASq7Q/artifacts/public/build/target.tar.bz2 03:51:24 INFO - Running post-action listener: _resource_record_post_action 03:51:24 INFO - Running post-action listener: set_extra_try_arguments 03:51:24 INFO - [mozharness: 2017-06-03 10:51:24.594188Z] Finished download-and-extract step (success) 03:51:24 INFO - [mozharness: 2017-06-03 10:51:24.594285Z] Running populate-webroot step. 03:51:24 INFO - Running pre-action listener: _resource_record_pre_action 03:51:24 INFO - Running main action method: populate_webroot 03:51:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:51:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:51:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:51:24 INFO - '--tppagecycles', 03:51:24 INFO - '7'], 03:51:24 INFO - 'tests': ['tsvgm']}}, 03:51:24 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:51:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:51:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:51:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:51:24 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:51:24 INFO - 'talos_options': ['--disable-e10s'], 03:51:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:51:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:51:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:51:24 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:51:24 INFO - 'talos_options': ['--disable-e10s'], 03:51:24 INFO - 'tests': ['damp', 'tps']}, 03:51:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:51:24 INFO - 'tests': ['damp', 'tps']}, 03:51:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:51:24 INFO - 'tests': ['dromaeo_dom']}, 03:51:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:51:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:51:24 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:51:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:51:24 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:51:24 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:51:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:51:24 INFO - 'tests': ['a11yr', 03:51:24 INFO - 'ts_paint', 03:51:24 INFO - 'tpaint', 03:51:24 INFO - 'sessionrestore', 03:51:24 INFO - 'sessionrestore_no_auto_restore', 03:51:24 INFO - 'tabpaint']}, 03:51:24 INFO - 'other-e10s': {'tests': ['a11yr', 03:51:24 INFO - 'ts_paint', 03:51:24 INFO - 'tpaint', 03:51:24 INFO - 'sessionrestore', 03:51:24 INFO - 'sessionrestore_no_auto_restore', 03:51:24 INFO - 'tabpaint']}, 03:51:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:51:24 INFO - 'ts_paint', 03:51:24 INFO - 'tpaint', 03:51:24 INFO - 'sessionrestore', 03:51:24 INFO - 'sessionrestore_no_auto_restore', 03:51:24 INFO - 'tabpaint']}, 03:51:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:51:24 INFO - 'ts_paint', 03:51:24 INFO - 'tpaint', 03:51:24 INFO - 'sessionrestore', 03:51:24 INFO - 'sessionrestore_no_auto_restore', 03:51:24 INFO - 'tabpaint']}, 03:51:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:51:24 INFO - 'tests': ['a11yr', 03:51:24 INFO - 'ts_paint', 03:51:24 INFO - 'tpaint', 03:51:24 INFO - 'sessionrestore', 03:51:24 INFO - 'sessionrestore_no_auto_restore', 03:51:24 INFO - 'tabpaint']}, 03:51:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:51:24 INFO - 'tests': ['a11yr', 03:51:24 INFO - 'ts_paint', 03:51:24 INFO - 'tpaint', 03:51:24 INFO - 'sessionrestore', 03:51:24 INFO - 'sessionrestore_no_auto_restore', 03:51:24 INFO - 'tabpaint']}, 03:51:24 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 03:51:24 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 03:51:24 INFO - 'bloom_basic_ref']}, 03:51:24 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 03:51:24 INFO - 'talos_options': ['--mitmproxy', 03:51:24 INFO - 'mitmproxy-recording-1.mp', 03:51:24 INFO - '--firstNonBlankPaint'], 03:51:24 INFO - 'tests': ['Quantum_1']}, 03:51:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:51:24 INFO - 'tests': ['tsvgx', 03:51:24 INFO - 'tsvgr_opacity', 03:51:24 INFO - 'tart', 03:51:24 INFO - 'tscrollx', 03:51:24 INFO - 'cart', 03:51:24 INFO - 'tsvg_static']}, 03:51:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:51:24 INFO - 'tsvgr_opacity', 03:51:24 INFO - 'tart', 03:51:24 INFO - 'tscrollx', 03:51:24 INFO - 'cart', 03:51:24 INFO - 'tsvg_static']}, 03:51:24 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:51:24 INFO - 'talos_options': ['--disable-e10s'], 03:51:24 INFO - 'tests': ['tp5o']}, 03:51:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:51:24 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:51:24 INFO - 'talos_options': ['--disable-e10s', 03:51:24 INFO - '--xperf_path', 03:51:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:51:24 INFO - 'tests': ['tp5n']}, 03:51:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:51:24 INFO - 'talos_options': ['--xperf_path', 03:51:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:51:24 INFO - 'tests': ['tp5n']}}, 03:51:24 INFO - 'talos.zip': {'path': '', 03:51:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:51:24 INFO - Running post-action listener: _resource_record_post_action 03:51:24 INFO - [mozharness: 2017-06-03 10:51:24.608703Z] Finished populate-webroot step (success) 03:51:24 INFO - [mozharness: 2017-06-03 10:51:24.608800Z] Running create-virtualenv step. 03:51:24 INFO - Running pre-action listener: _resource_record_pre_action 03:51:24 INFO - Running main action method: create_virtualenv 03:51:24 INFO - Creating virtualenv /builds/slave/test/build/venv 03:51:24 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:51:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:51:24 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:51:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:51:24 INFO - Using real prefix '/usr' 03:51:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:51:25 INFO - Installing distribute.............................................................................................................................................................................................done. 03:51:27 INFO - Installing pip.................done. 03:51:27 INFO - Return code: 0 03:51:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:51:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:51:27 INFO - Reading from file tmpfile_stdout 03:51:27 INFO - Output received: 03:51:27 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:51:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:51: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')]} 03:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51: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')]} 03:51:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16fc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a77840>, '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 0x1a78740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a78bd0>, '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': '6d15e502d8e29d5d2676d664000001c3-1496481317.185838-1999502738', '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 03:51:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:51:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:51:27 INFO - Using env: {'DISPLAY': ':0', 03:51:27 INFO - 'HOME': '/home/cltbld', 03:51:27 INFO - 'LANG': 'en_US.UTF-8', 03:51:27 INFO - 'LANGUAGE': 'en_US:en', 03:51:27 INFO - 'LOGNAME': 'cltbld', 03:51:27 INFO - 'MAIL': '/var/mail/cltbld', 03:51:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:27 INFO - 'MOZ_NO_REMOTE': '1', 03:51:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:27 INFO - 'NO_EM_RESTART': '1', 03:51:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:27 INFO - 'PWD': '/builds/slave/test', 03:51:27 INFO - 'SHELL': '/bin/bash', 03:51:27 INFO - 'SHLVL': '1', 03:51:27 INFO - 'TERM': 'linux', 03:51:27 INFO - 'TMOUT': '86400', 03:51:27 INFO - 'USER': 'cltbld', 03:51:27 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1496481317.185838-1999502738', 03:51:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:27 INFO - '_': '/tools/buildbot/bin/python'} 03:51:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:27 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:51:27 INFO - Cleaning up... 03:51:27 INFO - Return code: 0 03:51:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:51: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')]} 03:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51: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')]} 03:51:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16fc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a77840>, '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 0x1a78740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a78bd0>, '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': '6d15e502d8e29d5d2676d664000001c3-1496481317.185838-1999502738', '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 03:51:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:51:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:51:27 INFO - Using env: {'DISPLAY': ':0', 03:51:27 INFO - 'HOME': '/home/cltbld', 03:51:27 INFO - 'LANG': 'en_US.UTF-8', 03:51:27 INFO - 'LANGUAGE': 'en_US:en', 03:51:27 INFO - 'LOGNAME': 'cltbld', 03:51:27 INFO - 'MAIL': '/var/mail/cltbld', 03:51:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:27 INFO - 'MOZ_NO_REMOTE': '1', 03:51:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:27 INFO - 'NO_EM_RESTART': '1', 03:51:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:27 INFO - 'PWD': '/builds/slave/test', 03:51:27 INFO - 'SHELL': '/bin/bash', 03:51:27 INFO - 'SHLVL': '1', 03:51:27 INFO - 'TERM': 'linux', 03:51:27 INFO - 'TMOUT': '86400', 03:51:27 INFO - 'USER': 'cltbld', 03:51:27 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1496481317.185838-1999502738', 03:51:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:27 INFO - '_': '/tools/buildbot/bin/python'} 03:51:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:27 INFO - Downloading/unpacking psutil>=3.1.1 03:51: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 03:51: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 03:51: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 03:51: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 03:51:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:51:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:51:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:51:29 INFO - Installing collected packages: psutil 03:51:29 INFO - Running setup.py install for psutil 03:51:29 INFO - building 'psutil._psutil_linux' extension 03:51:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:51:29 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 03:51:29 INFO - building 'psutil._psutil_posix' extension 03:51:29 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 03:51:29 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 03:51:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:51:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:51:29 INFO - Successfully installed psutil 03:51:29 INFO - Cleaning up... 03:51:29 INFO - Return code: 0 03:51:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16fc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a77840>, '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 0x1a78740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a78bd0>, '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': '6d15e502d8e29d5d2676d664000001c3-1496481317.185838-1999502738', '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 03:51:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:51:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:51:29 INFO - Using env: {'DISPLAY': ':0', 03:51:29 INFO - 'HOME': '/home/cltbld', 03:51:29 INFO - 'LANG': 'en_US.UTF-8', 03:51:29 INFO - 'LANGUAGE': 'en_US:en', 03:51:29 INFO - 'LOGNAME': 'cltbld', 03:51:29 INFO - 'MAIL': '/var/mail/cltbld', 03:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:29 INFO - 'MOZ_NO_REMOTE': '1', 03:51:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:29 INFO - 'NO_EM_RESTART': '1', 03:51:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:29 INFO - 'PWD': '/builds/slave/test', 03:51:29 INFO - 'SHELL': '/bin/bash', 03:51:29 INFO - 'SHLVL': '1', 03:51:29 INFO - 'TERM': 'linux', 03:51:29 INFO - 'TMOUT': '86400', 03:51:29 INFO - 'USER': 'cltbld', 03:51:29 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1496481317.185838-1999502738', 03:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:29 INFO - '_': '/tools/buildbot/bin/python'} 03:51:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:51:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:51:30 INFO - Installing collected packages: mozsystemmonitor 03:51:30 INFO - Running setup.py install for mozsystemmonitor 03:51:31 INFO - Successfully installed mozsystemmonitor 03:51:31 INFO - Cleaning up... 03:51:31 INFO - Return code: 0 03:51:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:51:31 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')]} 03:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:31 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')]} 03:51:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:31 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 0x16fc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a77840>, '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 0x1a78740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a78bd0>, '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': '6d15e502d8e29d5d2676d664000001c3-1496481317.185838-1999502738', '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 03:51:31 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 03:51:31 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 03:51:31 INFO - Using env: {'DISPLAY': ':0', 03:51:31 INFO - 'HOME': '/home/cltbld', 03:51:31 INFO - 'LANG': 'en_US.UTF-8', 03:51:31 INFO - 'LANGUAGE': 'en_US:en', 03:51:31 INFO - 'LOGNAME': 'cltbld', 03:51:31 INFO - 'MAIL': '/var/mail/cltbld', 03:51:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:31 INFO - 'MOZ_NO_REMOTE': '1', 03:51:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:31 INFO - 'NO_EM_RESTART': '1', 03:51:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:31 INFO - 'PWD': '/builds/slave/test', 03:51:31 INFO - 'SHELL': '/bin/bash', 03:51:31 INFO - 'SHLVL': '1', 03:51:31 INFO - 'TERM': 'linux', 03:51:31 INFO - 'TMOUT': '86400', 03:51:31 INFO - 'USER': 'cltbld', 03:51:31 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1496481317.185838-1999502738', 03:51:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:31 INFO - '_': '/tools/buildbot/bin/python'} 03:51:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:31 INFO - Downloading/unpacking jsonschema==2.5.1 03:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:51:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:32 INFO - Downloading functools32-3.2.3-2.tar.gz 03:51:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:51:32 INFO - warning: no files found matching '*.txt' 03:51:32 INFO - no previously-included directories found matching 'build' 03:51:32 INFO - no previously-included directories found matching 'dist' 03:51:32 INFO - no previously-included directories found matching '.git*' 03:51:32 INFO - Installing collected packages: jsonschema, functools32 03:51:32 INFO - Running setup.py install for functools32 03:51:32 INFO - warning: no files found matching '*.txt' 03:51:32 INFO - no previously-included directories found matching 'build' 03:51:32 INFO - no previously-included directories found matching 'dist' 03:51:32 INFO - no previously-included directories found matching '.git*' 03:51:32 INFO - Successfully installed jsonschema functools32 03:51:32 INFO - Cleaning up... 03:51:32 INFO - Return code: 0 03:51:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x16fc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a77840>, '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 0x1a78740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a78bd0>, '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': '6d15e502d8e29d5d2676d664000001c3-1496481317.185838-1999502738', '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 03:51:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:51:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:51:32 INFO - Using env: {'DISPLAY': ':0', 03:51:32 INFO - 'HOME': '/home/cltbld', 03:51:32 INFO - 'LANG': 'en_US.UTF-8', 03:51:32 INFO - 'LANGUAGE': 'en_US:en', 03:51:32 INFO - 'LOGNAME': 'cltbld', 03:51:32 INFO - 'MAIL': '/var/mail/cltbld', 03:51:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:32 INFO - 'MOZ_NO_REMOTE': '1', 03:51:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:32 INFO - 'NO_EM_RESTART': '1', 03:51:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:32 INFO - 'PWD': '/builds/slave/test', 03:51:32 INFO - 'SHELL': '/bin/bash', 03:51:32 INFO - 'SHLVL': '1', 03:51:32 INFO - 'TERM': 'linux', 03:51:32 INFO - 'TMOUT': '86400', 03:51:32 INFO - 'USER': 'cltbld', 03:51:32 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1496481317.185838-1999502738', 03:51:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:32 INFO - '_': '/tools/buildbot/bin/python'} 03:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:51:33 INFO - Cleaning up... 03:51:33 INFO - Return code: 0 03:51:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x16fc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a77840>, '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 0x1a78740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a78bd0>, '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': '6d15e502d8e29d5d2676d664000001c3-1496481317.185838-1999502738', '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 03:51:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:51:33 INFO - Using env: {'DISPLAY': ':0', 03:51:33 INFO - 'HOME': '/home/cltbld', 03:51:33 INFO - 'LANG': 'en_US.UTF-8', 03:51:33 INFO - 'LANGUAGE': 'en_US:en', 03:51:33 INFO - 'LOGNAME': 'cltbld', 03:51:33 INFO - 'MAIL': '/var/mail/cltbld', 03:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:33 INFO - 'MOZ_NO_REMOTE': '1', 03:51:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:33 INFO - 'NO_EM_RESTART': '1', 03:51:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:33 INFO - 'PWD': '/builds/slave/test', 03:51:33 INFO - 'SHELL': '/bin/bash', 03:51:33 INFO - 'SHLVL': '1', 03:51:33 INFO - 'TERM': 'linux', 03:51:33 INFO - 'TMOUT': '86400', 03:51:33 INFO - 'USER': 'cltbld', 03:51:33 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1496481317.185838-1999502738', 03:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:33 INFO - '_': '/tools/buildbot/bin/python'} 03:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:33 INFO - Downloading/unpacking blobuploader==1.2.4 03:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:34 INFO - Downloading blobuploader-1.2.4.tar.gz 03:51:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:51:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:51:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:34 INFO - Downloading docopt-0.6.1.tar.gz 03:51:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:51:34 INFO - Installing collected packages: blobuploader, requests, docopt 03:51:34 INFO - Running setup.py install for blobuploader 03:51:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:51:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:51:35 INFO - Running setup.py install for requests 03:51:35 INFO - Running setup.py install for docopt 03:51:35 INFO - Successfully installed blobuploader requests docopt 03:51:35 INFO - Cleaning up... 03:51:35 INFO - Return code: 0 03:51:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:35 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 0x16fc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a77840>, '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 0x1a78740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a78bd0>, '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': '6d15e502d8e29d5d2676d664000001c3-1496481317.185838-1999502738', '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 03:51:35 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 03:51:35 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 03:51:35 INFO - Using env: {'DISPLAY': ':0', 03:51:35 INFO - 'HOME': '/home/cltbld', 03:51:35 INFO - 'LANG': 'en_US.UTF-8', 03:51:35 INFO - 'LANGUAGE': 'en_US:en', 03:51:35 INFO - 'LOGNAME': 'cltbld', 03:51:35 INFO - 'MAIL': '/var/mail/cltbld', 03:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:35 INFO - 'MOZ_NO_REMOTE': '1', 03:51:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:35 INFO - 'NO_EM_RESTART': '1', 03:51:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:35 INFO - 'PWD': '/builds/slave/test', 03:51:35 INFO - 'SHELL': '/bin/bash', 03:51:35 INFO - 'SHLVL': '1', 03:51:35 INFO - 'TERM': 'linux', 03:51:35 INFO - 'TMOUT': '86400', 03:51:35 INFO - 'USER': 'cltbld', 03:51:35 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1496481317.185838-1999502738', 03:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:35 INFO - '_': '/tools/buildbot/bin/python'} 03:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:51:35 INFO - Running setup.py (path:/tmp/pip-Dcu1AF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:51:35 INFO - Running setup.py (path:/tmp/pip-j9FV5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:51:35 INFO - Running setup.py (path:/tmp/pip-lMZVH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:51:36 INFO - Running setup.py (path:/tmp/pip-Cvyrbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:51:36 INFO - Running setup.py (path:/tmp/pip-e3EYuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:51:36 INFO - Running setup.py (path:/tmp/pip-GH5YYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:51:36 INFO - Running setup.py (path:/tmp/pip-QkHBnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:51:36 INFO - Running setup.py (path:/tmp/pip-E68dEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:51:36 INFO - Running setup.py (path:/tmp/pip-icHMIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:51:36 INFO - Running setup.py (path:/tmp/pip-zIGLW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:51:36 INFO - Running setup.py (path:/tmp/pip-kJLw2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:51:36 INFO - Running setup.py (path:/tmp/pip-hbSVWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:51:36 INFO - Running setup.py (path:/tmp/pip-pWd0bE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:51:36 INFO - Running setup.py (path:/tmp/pip-ESi7vA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:36 INFO - Running setup.py (path:/tmp/pip-usswOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:51:36 INFO - Running setup.py (path:/tmp/pip-IFZcUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:51:36 INFO - Running setup.py (path:/tmp/pip-5csA87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:51:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:51:37 INFO - Running setup.py install for manifestparser 03:51:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:51:37 INFO - Running setup.py install for mozcrash 03:51:37 INFO - Running setup.py install for mozdebug 03:51:37 INFO - Running setup.py install for mozdevice 03:51:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:51:37 INFO - Running setup.py install for mozfile 03:51:37 INFO - Running setup.py install for mozhttpd 03:51:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:51:37 INFO - Running setup.py install for mozinfo 03:51:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:51:37 INFO - Running setup.py install for mozInstall 03:51:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:51:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:51:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:51:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:51:37 INFO - Running setup.py install for mozleak 03:51:37 INFO - Running setup.py install for mozlog 03:51:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:51:38 INFO - Running setup.py install for moznetwork 03:51:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:51:38 INFO - Running setup.py install for mozprocess 03:51:38 INFO - Running setup.py install for mozprofile 03:51:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:51:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:51:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:51:38 INFO - Running setup.py install for mozrunner 03:51:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:51:38 INFO - Running setup.py install for mozscreenshot 03:51:38 INFO - Running setup.py install for moztest 03:51:38 INFO - Running setup.py install for mozversion 03:51:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:51:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:51:38 INFO - Cleaning up... 03:51:38 INFO - Return code: 0 03:51:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:38 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 0x16fc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a77840>, '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 0x1a78740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a78bd0>, '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': '6d15e502d8e29d5d2676d664000001c3-1496481317.185838-1999502738', '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 03:51:38 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 03:51:38 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 03:51:38 INFO - Using env: {'DISPLAY': ':0', 03:51:38 INFO - 'HOME': '/home/cltbld', 03:51:38 INFO - 'LANG': 'en_US.UTF-8', 03:51:38 INFO - 'LANGUAGE': 'en_US:en', 03:51:38 INFO - 'LOGNAME': 'cltbld', 03:51:38 INFO - 'MAIL': '/var/mail/cltbld', 03:51:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:38 INFO - 'MOZ_NO_REMOTE': '1', 03:51:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:38 INFO - 'NO_EM_RESTART': '1', 03:51:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:38 INFO - 'PWD': '/builds/slave/test', 03:51:38 INFO - 'SHELL': '/bin/bash', 03:51:38 INFO - 'SHLVL': '1', 03:51:38 INFO - 'TERM': 'linux', 03:51:38 INFO - 'TMOUT': '86400', 03:51:38 INFO - 'USER': 'cltbld', 03:51:38 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1496481317.185838-1999502738', 03:51:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:38 INFO - '_': '/tools/buildbot/bin/python'} 03:51:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:51:39 INFO - Running setup.py (path:/tmp/pip-QZGHDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:51:39 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)) 03:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:51:39 INFO - Running setup.py (path:/tmp/pip-Hdg8Bd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:51:39 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)) 03:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:51:39 INFO - Running setup.py (path:/tmp/pip-fcPGq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:51:39 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)) 03:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:51:39 INFO - Running setup.py (path:/tmp/pip-DfhwwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:51:39 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)) 03:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:51:39 INFO - Running setup.py (path:/tmp/pip-yLLetC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:51:39 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)) 03:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:51:39 INFO - Running setup.py (path:/tmp/pip-1GmNHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:51:39 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)) 03:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:51:39 INFO - Running setup.py (path:/tmp/pip-uDRY0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:51:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 03:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:51:39 INFO - Running setup.py (path:/tmp/pip-gMlcBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:51:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 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)) 03:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:51:39 INFO - Running setup.py (path:/tmp/pip-k2ourh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:51:39 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)) 03:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:51:39 INFO - Running setup.py (path:/tmp/pip-14ytZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:51:39 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)) 03:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:51:39 INFO - Running setup.py (path:/tmp/pip-IOaASb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:51:39 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)) 03:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:51:39 INFO - Running setup.py (path:/tmp/pip-ATk2vC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:51:39 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)) 03:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:51:39 INFO - Running setup.py (path:/tmp/pip-Gobx1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:51:39 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)) 03:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:51:39 INFO - Running setup.py (path:/tmp/pip-0GGkk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:51:40 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)) 03:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:40 INFO - Running setup.py (path:/tmp/pip-iyRSXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:40 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)) 03:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:51:40 INFO - Running setup.py (path:/tmp/pip-UY_Zuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:51:40 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)) 03:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:51:40 INFO - Running setup.py (path:/tmp/pip-R1Uzex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:51:40 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)) 03:51:40 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)) 03:51:40 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)) 03:51:40 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)) 03:51:40 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)) 03:51:40 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)) 03:51:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:51:40 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 03:51:40 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 03:51:40 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 03:51:40 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 03:51:41 INFO - Downloading blessings-1.6.tar.gz 03:51:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:51:41 INFO - Installing collected packages: blessings 03:51:41 INFO - Running setup.py install for blessings 03:51:41 INFO - Successfully installed blessings 03:51:41 INFO - Cleaning up... 03:51:41 INFO - Return code: 0 03:51:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:51:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:51:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:51:41 INFO - Reading from file tmpfile_stdout 03:51:41 INFO - Current package versions: 03:51:41 INFO - argparse == 1.2.1 03:51:41 INFO - blessings == 1.6 03:51:41 INFO - blobuploader == 1.2.4 03:51:41 INFO - docopt == 0.6.1 03:51:41 INFO - functools32 == 3.2.3-2 03:51:41 INFO - jsonschema == 2.5.1 03:51:41 INFO - manifestparser == 1.1 03:51:41 INFO - mozInstall == 1.12 03:51:41 INFO - mozcrash == 1.0 03:51:41 INFO - mozdebug == 0.1 03:51:41 INFO - mozdevice == 0.51 03:51:41 INFO - mozfile == 1.2 03:51:41 INFO - mozhttpd == 0.7 03:51:41 INFO - mozinfo == 0.9 03:51:41 INFO - mozleak == 0.1 03:51:41 INFO - mozlog == 3.4 03:51:41 INFO - moznetwork == 0.27 03:51:41 INFO - mozprocess == 0.25 03:51:41 INFO - mozprofile == 0.28 03:51:41 INFO - mozrunner == 6.13 03:51:41 INFO - mozscreenshot == 0.1 03:51:41 INFO - mozsystemmonitor == 0.3 03:51:41 INFO - moztest == 0.8 03:51:41 INFO - mozversion == 1.4 03:51:41 INFO - psutil == 3.1.1 03:51:41 INFO - requests == 1.2.3 03:51:41 INFO - wsgiref == 0.1.2 03:51:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:51:41 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')]} 03:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:41 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')]} 03:51:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:41 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 0x16fc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a77840>, '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 0x1a78740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a78bd0>, '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': '6d15e502d8e29d5d2676d664000001c3-1496481317.185838-1999502738', '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 03:51:41 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 03:51:41 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 03:51:41 INFO - Using env: {'DISPLAY': ':0', 03:51:41 INFO - 'HOME': '/home/cltbld', 03:51:41 INFO - 'LANG': 'en_US.UTF-8', 03:51:41 INFO - 'LANGUAGE': 'en_US:en', 03:51:41 INFO - 'LOGNAME': 'cltbld', 03:51:41 INFO - 'MAIL': '/var/mail/cltbld', 03:51:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:41 INFO - 'MOZ_NO_REMOTE': '1', 03:51:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:41 INFO - 'NO_EM_RESTART': '1', 03:51:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:41 INFO - 'PWD': '/builds/slave/test', 03:51:41 INFO - 'SHELL': '/bin/bash', 03:51:41 INFO - 'SHLVL': '1', 03:51:41 INFO - 'TERM': 'linux', 03:51:41 INFO - 'TMOUT': '86400', 03:51:41 INFO - 'USER': 'cltbld', 03:51:41 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1496481317.185838-1999502738', 03:51:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:41 INFO - '_': '/tools/buildbot/bin/python'} 03:51:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:51:42 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:43 INFO - Downloading marionette_driver-1.4.0.tar.gz 03:51:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 03:51:43 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)) 03:51:43 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)) 03:51:43 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)) 03:51:43 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)) 03:51:43 INFO - Installing collected packages: marionette-driver 03:51:43 INFO - Running setup.py install for marionette-driver 03:51:43 INFO - Successfully installed marionette-driver 03:51:43 INFO - Cleaning up... 03:51:43 INFO - Return code: 0 03:51:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:43 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 0x16fc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a77840>, '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 0x1a78740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a78bd0>, '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': '6d15e502d8e29d5d2676d664000001c3-1496481317.185838-1999502738', '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 03:51:43 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 03:51:43 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 03:51:43 INFO - Using env: {'DISPLAY': ':0', 03:51:43 INFO - 'HOME': '/home/cltbld', 03:51:43 INFO - 'LANG': 'en_US.UTF-8', 03:51:43 INFO - 'LANGUAGE': 'en_US:en', 03:51:43 INFO - 'LOGNAME': 'cltbld', 03:51:43 INFO - 'MAIL': '/var/mail/cltbld', 03:51:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:43 INFO - 'MOZ_NO_REMOTE': '1', 03:51:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:43 INFO - 'NO_EM_RESTART': '1', 03:51:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:43 INFO - 'PWD': '/builds/slave/test', 03:51:43 INFO - 'SHELL': '/bin/bash', 03:51:43 INFO - 'SHLVL': '1', 03:51:43 INFO - 'TERM': 'linux', 03:51:43 INFO - 'TMOUT': '86400', 03:51:43 INFO - 'USER': 'cltbld', 03:51:43 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1496481317.185838-1999502738', 03:51:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:43 INFO - '_': '/tools/buildbot/bin/python'} 03:51:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:51:43 INFO - Cleaning up... 03:51:43 INFO - Return code: 0 03:51:43 INFO - Running post-action listener: _resource_record_post_action 03:51:43 INFO - Running post-action listener: _start_resource_monitoring 03:51:43 INFO - Starting resource monitoring. 03:51:43 INFO - [mozharness: 2017-06-03 10:51:43.681952Z] Finished create-virtualenv step (success) 03:51:43 INFO - [mozharness: 2017-06-03 10:51:43.682422Z] Running install step. 03:51:43 INFO - Running pre-action listener: _resource_record_pre_action 03:51:43 INFO - Running main action method: install 03:51:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:51:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:51:43 INFO - Reading from file tmpfile_stdout 03:51:43 INFO - Detecting whether we're running mozinstall >=1.0... 03:51:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:51:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:51:43 INFO - Reading from file tmpfile_stdout 03:51:43 INFO - Output received: 03:51:43 INFO - Usage: mozinstall [options] installer 03:51:43 INFO - Options: 03:51:43 INFO - -h, --help show this help message and exit 03:51:43 INFO - -d DEST, --destination=DEST 03:51:43 INFO - Directory to install application into. [default: 03:51:43 INFO - "/builds/slave/test"] 03:51:43 INFO - --app=APP Application being installed. [default: firefox] 03:51:43 INFO - mkdir: /builds/slave/test/build/application 03:51:43 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'] 03:51:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:52:00 INFO - Reading from file tmpfile_stdout 03:52:00 INFO - Output received: 03:52:00 INFO - /builds/slave/test/build/application/firefox/firefox 03:52:00 INFO - Running post-action listener: _resource_record_post_action 03:52:00 INFO - [mozharness: 2017-06-03 10:52:00.832436Z] Finished install step (success) 03:52:00 INFO - [mozharness: 2017-06-03 10:52:00.832713Z] Running setup-mitmproxy step. 03:52:00 INFO - Running pre-action listener: _resource_record_pre_action 03:52:00 INFO - Running main action method: setup_mitmproxy 03:52:00 INFO - Skipping: mitmproxy is not required 03:52:00 INFO - Running post-action listener: _resource_record_post_action 03:52:00 INFO - [mozharness: 2017-06-03 10:52:00.833916Z] Finished setup-mitmproxy step (success) 03:52:00 INFO - [mozharness: 2017-06-03 10:52:00.834137Z] Running run-tests step. 03:52:00 INFO - Running pre-action listener: _resource_record_pre_action 03:52:00 INFO - Running main action method: run_tests 03:52:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:52:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:52:00 INFO - Python 2.7.3 03:52:00 INFO - Return code: 0 03:52:00 INFO - grabbing minidump binary from tooltool 03:52:00 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')]} 03:52:00 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 0x1a77840>, '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 0x1a78740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a78bd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:52:00 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 03:52:00 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 03:52:00 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 03:52:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:52:00 INFO - Return code: 0 03:52:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:52:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:52:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:52:00 INFO - ENV: RUST_BACKTRACE is now 1 03:52:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:52:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:52:00 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/Z6aQOLT8QLqJ2pnGOASq7Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 03:52:00 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/Z6aQOLT8QLqJ2pnGOASq7Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 03:52:00 INFO - Using env: {'DISPLAY': ':0', 03:52:00 INFO - 'HOME': '/home/cltbld', 03:52:00 INFO - 'LANG': 'en_US.UTF-8', 03:52:00 INFO - 'LANGUAGE': 'en_US:en', 03:52:00 INFO - 'LOGNAME': 'cltbld', 03:52:00 INFO - 'MAIL': '/var/mail/cltbld', 03:52:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:52:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:52:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:00 INFO - 'MOZ_NO_REMOTE': '1', 03:52:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:52:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:00 INFO - 'NO_EM_RESTART': '1', 03:52:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:00 INFO - 'PWD': '/builds/slave/test', 03:52:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:52:00 INFO - 'RUST_BACKTRACE': '1', 03:52:00 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:52:00 INFO - 'SHELL': '/bin/bash', 03:52:00 INFO - 'SHLVL': '1', 03:52:00 INFO - 'TERM': 'linux', 03:52:00 INFO - 'TMOUT': '86400', 03:52:00 INFO - 'USER': 'cltbld', 03:52:00 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1496481317.185838-1999502738', 03:52:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:00 INFO - '_': '/tools/buildbot/bin/python'} 03:52:00 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/Z6aQOLT8QLqJ2pnGOASq7Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 03:52:01 INFO - mozversion application_buildid: 20170603100243 03:52:01 INFO - mozversion application_changeset: 43039280fe464869428f03b047bb7c762784f44b 03:52:01 INFO - mozversion application_display_name: Nightly 03:52:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:52:01 INFO - mozversion application_name: Firefox 03:52:01 INFO - mozversion application_remotingname: firefox 03:52:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:52:01 INFO - mozversion application_vendor: Mozilla 03:52:01 INFO - mozversion application_version: 55.0a1 03:52:01 INFO - mozversion platform_buildid: 20170603100243 03:52:01 INFO - mozversion platform_changeset: 43039280fe464869428f03b047bb7c762784f44b 03:52:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:52:01 INFO - mozversion platform_version: 55.0a1 03:52:01 INFO - using testdate: 1496487121 03:52:01 INFO - actual date: 1496487121 03:52:01 INFO - starting webserver on 'localhost:45644' 03:52:01 INFO - SUITE-START | Running 2 tests 03:52:01 INFO - TEST-START | dromaeo_css 03:52:01 INFO - operating with platform_type : linux_ 03:52:01 INFO - Initialising browser for dromaeo_css test... 03:52:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45644/getInfo.html -profile /tmp/tmpxnSowJ/profile 03:52:01 INFO - TEST-INFO | started process 30687 (/builds/slave/test/build/application/firefox/firefox http://localhost:45644/getInfo.html) 03:52:35 INFO - TEST-INFO | 30687: killed by SIGTERM 03:52:35 INFO - Browser initialized. 03:52:35 INFO - Running cycle 1/1 for dromaeo_css test... 03:52:35 INFO - TEST-INFO | started process 30894 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxnSowJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:52:47 INFO - PID 30894 | RSS: Main: 181522432 03:52:47 INFO - PID 30894 | 03:55:47 INFO - PID 30894 | Cycle 1(1): loaded http://localhost:45644/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45644/tests/dromaeo/cssquery-ext.html) 03:55:48 INFO - PID 30894 | RSS: Main: 178900992 03:55:48 INFO - PID 30894 | 03:58:50 INFO - PID 30894 | Cycle 1(1): loaded http://localhost:45644/tests/dromaeo/cssquery-ext.html (next: http://localhost:45644/tests/dromaeo/cssquery-jquery.html) 03:58:50 INFO - PID 30894 | RSS: Main: 182104064 03:58:50 INFO - PID 30894 | 04:01:52 INFO - PID 30894 | Cycle 1(1): loaded http://localhost:45644/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45644/tests/dromaeo/cssquery-mootools.html) 04:01:53 INFO - PID 30894 | RSS: Main: 179806208 04:01:53 INFO - PID 30894 | 04:04:54 INFO - PID 30894 | Cycle 1(1): loaded http://localhost:45644/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45644/tests/dromaeo/cssquery-prototype.html) 04:04:55 INFO - PID 30894 | RSS: Main: 185946112 04:04:55 INFO - PID 30894 | 04:07:58 INFO - PID 30894 | Cycle 1(1): loaded http://localhost:45644/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45644/tests/dromaeo/cssquery-yui.html) 04:07:58 INFO - PID 30894 | RSS: Main: 182751232 04:07:58 INFO - PID 30894 | 04:11:00 INFO - PID 30894 | Cycle 1(1): loaded http://localhost:45644/tests/dromaeo/cssquery-yui.html (next: http://localhost:45644/tests/dromaeo/cssquery-dojo.html) 04:11:00 INFO - PID 30894 | RSS: Main: 181272576 04:11:00 INFO - PID 30894 | 04:11:00 INFO - PID 30894 | __start_tp_report 04:11:00 INFO - PID 30894 | _x_x_mozilla_page_load 04:11:00 INFO - PID 30894 | _x_x_mozilla_page_load_details 04:11:00 INFO - PID 30894 | |i|pagename|runs| 04:11:00 INFO - PID 30894 | |0;dojo.html;3287.7041066304014;3296.1430028192676;3302.7853189542684;3308.9669103308966;3341.298327351256;5794.304683437993;5852.297724273088;5861.17943487912;5873;5889.411058894114;5818.709064546777;5852.736626851792;5926.614770039955;5929.614575052618;5946.494547963417;4897.510248975092;5192.896142077157;5212.192110222922;5238.607104467161;5244.160934250521;5287.920681189786;5345.679259244458;5347.278117454132;5351.652142610717;5376.059189641816;5230.843074707784;5243.213517972296;5270.39390470097;5273.6572122811895;5281.102212623844;5288.391834938954;5288.867778305535;5298.894022119574;5313.734313284359;5347.59893008022;5215.843524694265;5248;5266.578673706094;5269.1569348903995;5278.841634750964;5776.104703770922;5834.095715164156;5887.411258874121;5896;5906.763729450817;6356.173697419306;6375.968120159416;6388.776392826276;6389.6805159741825;6400.615963042233;6444.903326450107;6446.387593178641;6447.355264473562;6453.903191452132;6460.773872914426;5852.122181672783;5944.851378715523;5975.073863551156;5976.999999999956;5978.730957106941;6417.743290268337;6427.55007149495;6440.645764482904;6503;6513.706883190268;6121.117656725397;6210.50315974721;6237.563370564108;6238.157848690459;6284.057391391328;6260.436560709558;6328.7468501260355;6329.841753956188;6338.271098823602;6344;6300.59046161998;6313.779017734358;6316.115743795872;6318.494520438354;6338.334474880071;6187.133801267826;6283.717232724538;6301.96849015752;6322.810315690536;6381.4575761059905;4866.31871537985;4868.342773725572;4874.147024270738;4888.755562221874;4914;4308.375285583636;4316.546762589883;4320.135972805451;4332.068605249887;4369.541198174146;5892.116182572563;5944.881102377928;5955.3151387590115;5960.225170727865;6001.969990150022;6298.08677741734;6321.525885558602;6342.04869269604;6355.841103972345;6411.743530258737;5923.703814809242;5923.911141332884;5925.259342582177;5933.525317974551;5974.761009559569;5325;5373.435789242073;5384.0847056000575;5388.7305634718105;5390.460953904657;6343.27052388972;6420.775272865428;6553.705083271169;6596.307387724316;6630.53586248958;6368.36316368378;6377.1390862233;6379.425851673372;6382.234131904202;6392;6597.637129957899;6602.570832895846;6606.9008964866525;6610.338966103352;6614.669266536558;6182.443580077815;6227.626342419469;6232.283287422005;6268.623882567061;6308.589941653778;6303.936960630335;6313.842153946004;6327.936720632735;6337.524685648503;6347.238331400262;6093.847653808691;6126.172966649624;6128.050152226412;6128.105930682507;6150.569460137747;6132.4166970161305;6147.047207682816;6269.404406581368;6270.655113968775;6289.433950944437;6273.498120150468;6276.6547839869245;6303.621782693053;6311.747530098744;6314.273858506331;6295.496360291258;6336.714847831767;6356.682165891594;6362.268339141058;6365.90451143224;6070.605410648471;6084.14821924922;6111.04482360895;6120.90429240112;6169.56813023084 04:11:00 INFO - PID 30894 | |1;ext.html;687.384790612402;739.3087463221888;756.1644382956835;1080.292408472451;1097.0839349143464;35728.64271357286;36303.63696363036;36429.27141457169;36604.99999999996;36612.63387366125;38239.23521529575;38501.422478662775;38513.614863851355;38516;38610.22779544407;7056;7088.503804733684;7188.173360063581;7189.748358807443;7228.566286022829;6601.306862779411;6611.371919667624;6614.570052946568;6616.139901812758;6625.536212465106;6588.868222635544;6595.571287866273;6640.966795166041;6641.269460359356;6647.50143739219;6594.241662208859;6609.867802643968;6611.636360000198;6623.668816559153;6626;7158.427325813923;7169.103862017248;7179.856402871966;7183.676734546906;7195.6042417667;35510.467342989876;35525.28949421023;35602.465963010574;35635.28729425397;35643.64356356429;3433.4163192257374;3440.397930362177;3442.1394651337164;3467.7052450541732;3473.531073305097;28120.437591248265;28146.718532814615;28194.295142621395;28232.576511352345;28272.15183544497;3489.162600975773;3568.2506673598577;3586.7309951753464;3587.4798154267746;3631.346357655621;163296.18351908165;164047;179294;198939;201490;42568;42730.57269427328;42848.92877678083;43070;43086.56913430826;44367.33448998268;44508;44681.55318446774;44688.3296750549;44874;14035.78946315806;14083.85916140846;14109.153450792985;14123.858761412459;14173.645658858404;11486.94256528712;11501;11560.768784624428;11564;11573.132015098901;13221.405036773369;13507;13529.59411217665;13614.591562253148;13629.795553066711;5627.943720562742;5671.858203544944;5711.228984087095;5766.654000759968;5810.448007439287;1047.4762618690654;1053.8788039375418;1063.728749168957;1070.946452677363;1071.566015763617;23216.53566928686;24798.87600562022;25386.619200712004;25410.74589254084;25534.616980745304;1125.9718507037226;1144.722003213599;1151.113642495274;1152.504423098076;1198.6583823610229;12231.266124032409;16625.08562029076;16980.830191697925;17216.569585760455;17254.309827607005;257060;258555;258993;259470;259964;50583.49416505788;54626.72686636541;54826.17760733592;54968.45031549713;55004.72497637566;1431.8496557861483;1469.0818238600875;1482.0292708276097;1486.3980088064136;1495.827979782339;26234.606480903185;29439;29930.551041733957;30204.395912081196;30260.69739302579;37324;37532.437013445364;37600.2479950394;37628.623713762514;37802.2439551202;221255;221728;222341;222425;222724;32450.18874528061;32517.837410812794;32530.837345814067;33761.49357759685;33878.830605846815;40818.79590602028;41914;42283.36574951317;42377.78811105925;42591.3611295837;29036.419271614872;29585.408291833613;30100.247493811952;30625;32658;29808.254793630334;30607;30781.846090769403;32545.186370340933;32605.347893041533;35832.4625130618;36219.27561448704;36653.26693466063;36668.44997325096;37137.0715732098;27918;28982.07304758154;29706.851465742533;30674.693253067184;31759;24549.63175552404;25716.485670286114;25806.35484112837;25832.612510811978;26237.212883613523 04:11:00 INFO - PID 30894 | |2;jquery.html;445.3342253331268;452.6650278793693;453.1164229751984;469.19064613541633;471.98820029499257;19841.305554305603;20943.266985655486;20950.057247423865;22530.77469225307;23374.41563960902;23658.408539786513;24087.518249634995;24159.879200604017;24169.637455438184;24244.27267181983;5601.159826026098;5676.659400435987;5689.089745640677;5712.171735098408;5717.113847353667;5601.523870471015;5625.8593535161535;5644.04051311276;5645.350784659776;5663.546916246691;5530.861728456801;5638.267025286707;5745.023346031185;5764.702941838094;5784.768609255646;5707.971460142714;5728.885422291552;5734.168545560912;5748.885022299552;5749.511291540203;5214.895702085975;5217.8173763918085;5218.373795144569;5234.8691282717855;5238.842834714965;26437;26863.194104176906;26925;26950.865245673645;27030.459390812073;2068.369147410039;2152.2359562355296;2168.642174041281;2168.6530155175255;2177.3032629558547;18204.45386638403;18423.526117910536;18477.353292634692;18533.536661583432;18604.906975465172;2192.903548225887;2272.863628182314;2296.908123675051;2298.931032069024;2301.7583153768783;121452;122335.38832305871;130202.34898825445;130294;130317;12548.749025019448;13138.211707297593;13228.206307621573;13235.27206003679;13307.205486847677;18360.90819545894;18467.353642622445;18510.16704248312;18510.629787404447;18601.7209741854;8731.956340218258;9316.487593182304;9493.288003399635;9710.077542633438;9744.220462362993;8812.515311657791;9000.549972501349;9020.729378118667;9083.636654533877;9131.634734610674;8325.417220794487;8431.704890328809;8449.112843151504;8470.15298470148;8549.187827156411;2265.546890621882;2313.9652905206435;2344.3318654183477;2365.8107351411845;2483.081259933836;943.8253923024263;974.2303580171726;979.5738853598565;989.248171389749;1026.553449249564;18846.811531884505;18932.836638544955;19429.80570194308;20028.89985550092;20121.295754648516;1006.9798604027878;1024.3469414217213;1039.4387031003173;1045.8012977534245;1071.6249312740479;10724.78550428987;10850.535177750902;11014.173936954761;11444.427778611036;11464.254823436617;438982;445417;450249;451704;457498;97204;98538.50730746443;98828.50585747026;99236.50381748189;100401.49799251102;1175.5004123247757;1195.8146487294484;1255.8555766087018;1256.0830593666492;1256.7298030923396;19299.614007720047;20702.689459658417;21809;21909.67135492937;21932;51082.489175107774;51486.74256628693;53028.46971530235;53238.20142697785;53300.73349633382;64663.67668161629;64948;65135;65296;66105.33894661184;10875.40185289785;11173.27373720738;11190.32858028521;11195.38425386579;11242.10063194926;17981.55046123805;18097.36659216921;18110.81889181091;18357.632847342713;18407.81592184061;14359.256297481092;15893.841061589235;15955.441559545361;16065.357385704909;16205.108719020567;12917.935410322889;13280.734385312433;13459.596212113653;13638.181709097486;13784.379702913593;15106.697866042838;15284.312205950537;15390.384384624938;15429.691406172038;15438.30527626282;10982.615608453665;11009.504572294105;11009.61466348674;11072.557097716;11094.500747466222;14874.628134296296;15014.549563513112;15062.32219550101;15473.5357939262;15474.690506190038 04:11:00 INFO - PID 30894 | |3;mootools.html;1340.155701907798;1396.7485852546545;1398.9088510961453;1407.7888316752485;1407.9929600351998;11743.003689372807;11874.703132421671;12174.817377739319;12270.509179632814;12437.751244975096;11936.94031529841;12065.879341206586;12157.817632735516;12164.513419463234;12164.756704865897;2100.0864623888583;2165.1447678167115;2175.2386664667397;2176.836737244705;2181.018541656253;2172.435166856613;2225.9666105008437;2228.43174990378;2245.057076028064;2246.3934737620834;2194.6049711052005;2199.6480563109903;2202.757696653367;2221.7111775469166;2223.2552095048177;2173.89130543473;2183.7816218378193;2184.683220932956;2187.5406164705432;2203.7575866654734;2077.6987336836223;2110.4196346004974;2115.640341141994;2120.8091271785615;2125.1393185759794;11815.704607384798;11984.101192410604;12009.399530023464;12037;12048.216865903689;6484.383983521605;6615.636140012298;6669.666516674195;6677.065210870482;6700.162479690039;3861.362875125629;3943.397357743875;3985.262726395626;4035.9192816143805;4072.6334629883454;1292.3473645808901;1313.5862203405898;1314.7436249931268;1315.5987423835727;1337.6321511584392;18604.720929186074;18717.62564748711;18752.156152973148;18759.906200469046;19344.516387090436;5299.178627312773;5322.042032434199;5347.518723314843;5394.91907621386;5491.450854914477;13779.379927903268;13789.379477923518;13806.240656763974;13852.030357875054;13897.16617002983;6453.515986301046;6545.410913017756;6545.934540654533;6561.475081993429;6567.507436942248;6048.243969503812;6059;6117.908231376533;6130.632162070201;6162.568620196544;4185.874423767292;4278.572142785696;4292.077203401283;4340.978295108504;4370.8033138508845;1234.530878266271;1248.1076030637955;1263.1473755215193;1267.4296566545092;1276.1577358943052;888.5379602606738;910.4355299714219;919.7930465645177;931.8322701913585;933.3513208320152;6931.89602155958;7663;7718.228177182237;7959.084705258853;8033.6786528538205;993.3841018568534;1017.7786656012814;1025.0723095598496;1027.9743006424899;1048.0933992096782;4781.784819683123;4885.76274568491;5088.567471764867;5376.892462150735;5397.78408863641;15425.537233883002;16426.096564688818;16522.173891305385;16804.74792878108;16826.915865420593;15649.139297338528;15820.129892855774;16006;16047.598810029842;16048;9091.954540227389;9314.254859611216;9316.301277404222;9498;9983.201343892471;7459.925400745923;7767.417443691633;7791.64937577799;7830.960845195737;8274.29668478186;14026.929865351016;14052.437902483785;14093.083949543246;14217.289135542975;14547.563573092824;14347.354369053626;14364.712705746035;14452.566423007327;14522.85477145215;14713.92643036778;10013.24900632441;10135.290529662852;10143.391396515937;10245.180385568987;10274;11178.664640060812;11235.213535052468;11375.943120284346;11417.31496110236;11426.885731142582;9255.67605133817;9477.952610236905;9536.046395360408;9636.951815240878;9712.951435242778;9182.632694692138;9370.718878433658;9426.764330891783;9448.763780905258;9723.173530250007;8365.288950439037;8504.064552899299;8519.318454523747;8536.359773016924;8538.914610853812;6132.601380910227;6560.901586476302;6591.373819487141;6892.551984121016;7091.43268538526;6704.094947182068;6717.395434410926;6964.094667693167;6971.163460384786;7237.312455316736 04:11:00 INFO - PID 30894 | |4;prototype.html;430.1418669753842;430.79537219820577;437.45536806675693;439.89222640453113;442.47787610619457;6033.69831508425;6143.692815359236;6186.597871138379;6197;6241.563090583655;5914.9112763308585;6039.456448919596;6039.939600603992;6046.3349031606485;6058.575899687013;4574.9542504574865;4659.9534004659945;4676.181668208067;4683.227267500875;4684.672072954894;4688.695234809744;4689.9531004690025;4704.341392205077;4718.952810471886;4719.811207551694;4659;4661.44062712475;4669.2062349400685;4692.577668009879;4702.764861756916;4688.789004494806;4700.318453824177;4702.27114797207;4702.365180700596;4702.388689470347;4151.066010147722;4152.252594532983;4167.166566686675;4167.83328666853;4171.311733563958;5953.196318496991;5987.37132601075;6018.127371531104;6029.668368239745;6044.214252147237;5513.255710479074;5534.557235421156;5543.085390910495;5547.807221447368;5554.222408862763;6486.870262594722;6488.480921526267;6500.512461565354;6525.869482610321;6529.706163222619;4678.649101317381;4684.95315046852;4686.273627587695;4689.320048592935;4692.882677933045;6400.839979000516;6750.459963202981;6752.493562982796;6810.182778066614;6844.178698556156;4673.742944138037;4744.383230180124;4747.0299825572;4750.691205071659;4763.1426343258545;4776.47458779534;4794.664373493822;4805.975970120127;4807.735574543363;4836.516348365206;5343;5450.155225939986;5494.120940649477;5499.752511137009;5508.889822203533;6458.483321334282;6492.285848556655;6492.480601551959;6509.121268628769;6529.967350163219;1657.9088150151858;1659.8008239011397;1666.275170300923;1670.13987796285;1675.3633619224618;1115.252780636975;1134.1040577943331;1154.6132045764596;1156.6183159557327;1161.0653423993597;6146.555559443527;6147.877042459126;6175.9073613894925;6185.783497577563;6192.752289908353;6630.403263706193;6639.800805975829;6664.900026499607;6668.633225172662;6699.497537684693;6099.939000610026;6125;6129;6161.568690191643;6171.537134714914;3494.545709057806;3517.9472307915403;3533.840977156034;3535.5403797506674;3561.1097225693575;6866.279040700754;6902.861942761117;6908.378245957888;6918.792436226921;6922.376986071177;6752.493562982698;6811.625360605214;6818.215905170969;6830.146231721035;6845.965770171118;6831.8138195777865;6893.620850853151;6925.965370173117;6943.270956549591;6957.234704182536;6611.834704132243;6643.368879956396;6665.733370665119;6669.566043300713;6710.698018589078;6571.737130514726;6637.336266373324;6642.335766423319;6646.966765166143;6651.667416629246;6569.2263088966665;6875.209350924708;6882.311768823078;6914.204866440223;6917.342852429011;4724.433068031858;4737.905241895074;4766.976165119152;4769.73766442849;4780.11567859947;6492.610443373413;6619.933800661932;6624.536282460374;6692.83267918306;6710.731570737116;6434.940818937895;6451.935480645134;6459.644719540471;6466.741330346922;6472.935270647422;6421.454176395058;6440.035789084374;6453.806045881527;6486.610803351814;6506.089147519446;6314.400131987454;6419.4864410846085;6428.100065990859;6431.421172094534;6512.413882750575;6447.258565265054;6469.902951455638;6475.546711730133;6509.286495502844;6525.673716314261;6265.686715664289;6286.214223222098;6309.242890852944;6329.1139240505445;6368.87262254743 04:11:00 INFO - PID 30894 | |5;yui.html;816.6488409983712;822.169608695218;834.4159088637953;843.8017065989492;858.8883445152129;17703.46889593311;18118.184681689338;18128.728069078974;19671.409857704257;20987.160513579478;17476;17553.56116097098;17565.560860978483;17575.91212043941;17701.91149044253;967.7048500207452;985.8816941966974;991.3853410885262;991.6281394477071;993;976.0629795396393;996.7707427291691;1006.0342071611262;1007.6876168387787;1010.2927950434688;1055.6938487838518;1067.215596536549;1067.743741502038;1067.7757670889123;1067.9893201068007;1037.766502536923;1041.9114375278111;1044.780596074825;1045.3936716704332;1045.9529321180528;761.4213197969527;762.4624639629104;767.9769606911801;768.3353898877431;769.9230076992256;17910;18078.90960545202;18205.817941820544;18211.908940455345;19072;17778.644427111387;18700.812991870043;18921.526961826065;18967.81032189674;19061.809381906143;15182.924085379613;15275.083494990226;15278.236088195657;15299.15854627995;15301.923490382587;3331.6335203127637;3355.446351352024;3355.7818741781707;3369.8146601936883;3377.9662203378143;96157;96459;96768.51615741877;97689;98443;14020.85979140216;14244.786328204878;14418.351174197187;14570.927145364205;14624.049436786787;25952.74047259541;27319.863400683265;27535.173944781687;27580;27597.724022759514;7491.66287517063;8186.959065204755;8333.458325208841;8361.456505327256;8410.453320534145;3780.3762379207124;3787.299349620329;3809.6380843819793;3876.3022655922205;3910.550286717064;3911.3546264866545;3922.490076290064;3962.167944731581;3981.8606348777653;4119.258533464005;809.9919000809916;825.859603867344;829.8796674482167;836.0719601242616;836.5315423362814;699.1435491522844;717.6340066566089;719.4675939804507;721.5237942957623;726.7202127181073;11183.608573699881;11818.290902545874;12844.935775321064;13176.538821141214;13377.73244535104;714.9285071492809;715.5134508534143;718.8741970155202;725.7496163823578;732.5018987088724;5387.676739395649;5737.479567914506;5758.330084275597;5831.329397119301;5861.912071318934;116653.4167329175;116899;118152;118320;123125.38437307936;98641;99278;100416.49791751141;101488.49255753674;102928;85901;88332.64356697258;88487.11512884918;89524.552377239;91012.54493727621;10673.35959842412;10693.465326733476;11056.723581910517;11472.426378681199;11586.88413115858;38127.80936095302;38426;38454;38636.420453692655;39938.400923986745;49433;49529;49881;50440.49559504358;51404;15370.846291536942;15617.297221624827;16028.759568606247;16117.274722637743;16196.67606647884;17890.463286101436;20751.27370542084;21388.679169812152;21785.455363616038;21817.890910545346;17953.102344882966;18053.548661283574;18230.635387292445;18343.724844127617;18487.075646217367;17586.560335991704;17638.647227055644;17728.55678608045;17982.190801413704;18287.725684115016;18187.545311366794;18565.25738970426;18607.44177674672;18803.05984700787;19040.52398690044;11986.700332491757;12423;12462;12510.624681259576;12651.367431628198;13327.267000315076;13867.583972480841;15279.541613751606;16001.519954401387;16065.27706253198 04:11:00 INFO - PID 30894 | __end_tp_report 04:11:00 INFO - PID 30894 | __start_cc_report 04:11:00 INFO - PID 30894 | _x_x_mozilla_cycle_collect,331 04:11:00 INFO - PID 30894 | __end_cc_report 04:11:00 INFO - PID 30894 | __startTimestamp1496488260845__endTimestamp 04:11:00 INFO - PID 30894 | 04:11:00 INFO - PID 30894 | ------- Summary: start ------- 04:11:00 INFO - PID 30894 | Number of tests: 6 04:11:00 INFO - PID 30894 | 04:11:00 INFO - PID 30894 | [#0] dojo.html Cycles:165 Average:5866.92 Median:6128.05 stddev:702.54 (11.5%) stddev-sans-first:674.93 04:11:00 INFO - PID 30894 | Values: 3287.7 3296.1 3302.8 3309.0 3341.3 5794.3 5852.3 5861.2 5873.0 5889.4 5818.7 5852.7 5926.6 5929.6 5946.5 4897.5 5192.9 5212.2 5238.6 5244.2 5287.9 5345.7 5347.3 5351.7 5376.1 5230.8 5243.2 5270.4 5273.7 5281.1 5288.4 5288.9 5298.9 5313.7 5347.6 5215.8 5248.0 5266.6 5269.2 5278.8 5776.1 5834.1 5887.4 5896.0 5906.8 6356.2 6376.0 6388.8 6389.7 6400.6 6444.9 6446.4 6447.4 6453.9 6460.8 5852.1 5944.9 5975.1 5977.0 5978.7 6417.7 6427.6 6440.6 6503.0 6513.7 6121.1 6210.5 6237.6 6238.2 6284.1 6260.4 6328.7 6329.8 6338.3 6344.0 6300.6 6313.8 6316.1 6318.5 6338.3 6187.1 6283.7 6302.0 6322.8 6381.5 4866.3 4868.3 4874.1 4888.8 4914.0 4308.4 4316.5 4320.1 4332.1 4369.5 5892.1 5944.9 5955.3 5960.2 6002.0 6298.1 6321.5 6342.0 6355.8 6411.7 5923.7 5923.9 5925.3 5933.5 5974.8 5325.0 5373.4 5384.1 5388.7 5390.5 6343.3 6420.8 6553.7 6596.3 6630.5 6368.4 6377.1 6379.4 6382.2 6392.0 6597.6 6602.6 6606.9 6610.3 6614.7 6182.4 6227.6 6232.3 6268.6 6308.6 6303.9 6313.8 6327.9 6337.5 6347.2 6093.8 6126.2 6128.1 6128.1 6150.6 6132.4 6147.0 6269.4 6270.7 6289.4 6273.5 6276.7 6303.6 6311.7 6314.3 6295.5 6336.7 6356.7 6362.3 6365.9 6070.6 6084.1 6111.0 6120.9 6169.6 04:11:00 INFO - PID 30894 | 04:11:00 INFO - PID 30894 | [#1] ext.html Cycles:180 Average:38038.08 Median:33820.16 stddev:58043.05 (171.6%) stddev-sans-first:58138.13 04:11:00 INFO - PID 30894 | Values: 687.4 739.3 756.2 1080.3 1097.1 35728.6 36303.6 36429.3 36605.0 36612.6 38239.2 38501.4 38513.6 38516.0 38610.2 7056.0 7088.5 7188.2 7189.7 7228.6 6601.3 6611.4 6614.6 6616.1 6625.5 6588.9 6595.6 6641.0 6641.3 6647.5 6594.2 6609.9 6611.6 6623.7 6626.0 7158.4 7169.1 7179.9 7183.7 7195.6 35510.5 35525.3 35602.5 35635.3 35643.6 3433.4 3440.4 3442.1 3467.7 3473.5 28120.4 28146.7 28194.3 28232.6 28272.2 3489.2 3568.3 3586.7 3587.5 3631.3 163296.2 164047.0 179294.0 198939.0 201490.0 42568.0 42730.6 42848.9 43070.0 43086.6 44367.3 44508.0 44681.6 44688.3 44874.0 14035.8 14083.9 14109.2 14123.9 14173.6 11486.9 11501.0 11560.8 11564.0 11573.1 13221.4 13507.0 13529.6 13614.6 13629.8 5627.9 5671.9 5711.2 5766.7 5810.4 1047.5 1053.9 1063.7 1070.9 1071.6 23216.5 24798.9 25386.6 25410.7 25534.6 1126.0 1144.7 1151.1 1152.5 1198.7 12231.3 16625.1 16980.8 17216.6 17254.3 257060.0 258555.0 258993.0 259470.0 259964.0 50583.5 54626.7 54826.2 54968.5 55004.7 1431.8 1469.1 1482.0 1486.4 1495.8 26234.6 29439.0 29930.6 30204.4 30260.7 37324.0 37532.4 37600.2 37628.6 37802.2 221255.0 221728.0 222341.0 222425.0 222724.0 32450.2 32517.8 32530.8 33761.5 33878.8 40818.8 41914.0 42283.4 42377.8 42591.4 29036.4 29585.4 30100.2 30625.0 32658.0 29808.3 30607.0 30781.8 32545.2 32605.3 35832.5 36219.3 36653.3 36668.4 37137.1 27918.0 28982.1 29706.9 30674.7 31759.0 24549.6 25716.5 25806.4 25832.6 26237.2 04:11:00 INFO - PID 30894 | 04:11:00 INFO - PID 30894 | [#2] jquery.html Cycles:180 Average:31434.41 Median:22231.39 stddev:75527.29 (339.7%) stddev-sans-first:75703.32 04:11:00 INFO - PID 30894 | Values: 445.3 452.7 453.1 469.2 472.0 19841.3 20943.3 20950.1 22530.8 23374.4 23658.4 24087.5 24159.9 24169.6 24244.3 5601.2 5676.7 5689.1 5712.2 5717.1 5601.5 5625.9 5644.0 5645.4 5663.5 5530.9 5638.3 5745.0 5764.7 5784.8 5708.0 5728.9 5734.2 5748.9 5749.5 5214.9 5217.8 5218.4 5234.9 5238.8 26437.0 26863.2 26925.0 26950.9 27030.5 2068.4 2152.2 2168.6 2168.7 2177.3 18204.5 18423.5 18477.4 18533.5 18604.9 2192.9 2272.9 2296.9 2298.9 2301.8 121452.0 122335.4 130202.3 130294.0 130317.0 12548.7 13138.2 13228.2 13235.3 13307.2 18360.9 18467.4 18510.2 18510.6 18601.7 8732.0 9316.5 9493.3 9710.1 9744.2 8812.5 9000.5 9020.7 9083.6 9131.6 8325.4 8431.7 8449.1 8470.2 8549.2 2265.5 2314.0 2344.3 2365.8 2483.1 943.8 974.2 979.6 989.2 1026.6 18846.8 18932.8 19429.8 20028.9 20121.3 1007.0 1024.3 1039.4 1045.8 1071.6 10724.8 10850.5 11014.2 11444.4 11464.3 438982.0 445417.0 450249.0 451704.0 457498.0 97204.0 98538.5 98828.5 99236.5 100401.5 1175.5 1195.8 1255.9 1256.1 1256.7 19299.6 20702.7 21809.0 21909.7 21932.0 51082.5 51486.7 53028.5 53238.2 53300.7 64663.7 64948.0 65135.0 65296.0 66105.3 10875.4 11173.3 11190.3 11195.4 11242.1 17981.6 18097.4 18110.8 18357.6 18407.8 14359.3 15893.8 15955.4 16065.4 16205.1 12917.9 13280.7 13459.6 13638.2 13784.4 15106.7 15284.3 15390.4 15429.7 15438.3 10982.6 11009.5 11009.6 11072.6 11094.5 14874.6 15014.5 15062.3 15473.5 15474.7 04:11:00 INFO - PID 30894 | 04:11:00 INFO - PID 30894 | [#3] mootools.html Cycles:180 Average:7557.37 Median:2201.20 stddev:4982.92 (226.4%) stddev-sans-first:4975.00 04:11:00 INFO - PID 30894 | Values: 1340.2 1396.7 1398.9 1407.8 1408.0 11743.0 11874.7 12174.8 12270.5 12437.8 11936.9 12065.9 12157.8 12164.5 12164.8 2100.1 2165.1 2175.2 2176.8 2181.0 2172.4 2226.0 2228.4 2245.1 2246.4 2194.6 2199.6 2202.8 2221.7 2223.3 2173.9 2183.8 2184.7 2187.5 2203.8 2077.7 2110.4 2115.6 2120.8 2125.1 11815.7 11984.1 12009.4 12037.0 12048.2 6484.4 6615.6 6669.7 6677.1 6700.2 3861.4 3943.4 3985.3 4035.9 4072.6 1292.3 1313.6 1314.7 1315.6 1337.6 18604.7 18717.6 18752.2 18759.9 19344.5 5299.2 5322.0 5347.5 5394.9 5491.5 13779.4 13789.4 13806.2 13852.0 13897.2 6453.5 6545.4 6545.9 6561.5 6567.5 6048.2 6059.0 6117.9 6130.6 6162.6 4185.9 4278.6 4292.1 4341.0 4370.8 1234.5 1248.1 1263.1 1267.4 1276.2 888.5 910.4 919.8 931.8 933.4 6931.9 7663.0 7718.2 7959.1 8033.7 993.4 1017.8 1025.1 1028.0 1048.1 4781.8 4885.8 5088.6 5376.9 5397.8 15425.5 16426.1 16522.2 16804.7 16826.9 15649.1 15820.1 16006.0 16047.6 16048.0 9092.0 9314.3 9316.3 9498.0 9983.2 7459.9 7767.4 7791.6 7831.0 8274.3 14026.9 14052.4 14093.1 14217.3 14547.6 14347.4 14364.7 14452.6 14522.9 14713.9 10013.2 10135.3 10143.4 10245.2 10274.0 11178.7 11235.2 11375.9 11417.3 11426.9 9255.7 9478.0 9536.0 9637.0 9713.0 9182.6 9370.7 9426.8 9448.8 9723.2 8365.3 8504.1 8519.3 8536.4 8538.9 6132.6 6560.9 6591.4 6892.6 7091.4 6704.1 6717.4 6964.1 6971.2 7237.3 04:11:00 INFO - PID 30894 | 04:11:00 INFO - PID 30894 | [#4] prototype.html Cycles:180 Average:5445.44 Median:6147.22 stddev:1605.03 (26.1%) stddev-sans-first:1564.77 04:11:00 INFO - PID 30894 | Values: 430.1 430.8 437.5 439.9 442.5 6033.7 6143.7 6186.6 6197.0 6241.6 5914.9 6039.5 6039.9 6046.3 6058.6 4575.0 4660.0 4676.2 4683.2 4684.7 4688.7 4690.0 4704.3 4719.0 4719.8 4659.0 4661.4 4669.2 4692.6 4702.8 4688.8 4700.3 4702.3 4702.4 4702.4 4151.1 4152.3 4167.2 4167.8 4171.3 5953.2 5987.4 6018.1 6029.7 6044.2 5513.3 5534.6 5543.1 5547.8 5554.2 6486.9 6488.5 6500.5 6525.9 6529.7 4678.6 4685.0 4686.3 4689.3 4692.9 6400.8 6750.5 6752.5 6810.2 6844.2 4673.7 4744.4 4747.0 4750.7 4763.1 4776.5 4794.7 4806.0 4807.7 4836.5 5343.0 5450.2 5494.1 5499.8 5508.9 6458.5 6492.3 6492.5 6509.1 6530.0 1657.9 1659.8 1666.3 1670.1 1675.4 1115.3 1134.1 1154.6 1156.6 1161.1 6146.6 6147.9 6175.9 6185.8 6192.8 6630.4 6639.8 6664.9 6668.6 6699.5 6099.9 6125.0 6129.0 6161.6 6171.5 3494.5 3517.9 3533.8 3535.5 3561.1 6866.3 6902.9 6908.4 6918.8 6922.4 6752.5 6811.6 6818.2 6830.1 6846.0 6831.8 6893.6 6926.0 6943.3 6957.2 6611.8 6643.4 6665.7 6669.6 6710.7 6571.7 6637.3 6642.3 6647.0 6651.7 6569.2 6875.2 6882.3 6914.2 6917.3 4724.4 4737.9 4767.0 4769.7 4780.1 6492.6 6619.9 6624.5 6692.8 6710.7 6434.9 6451.9 6459.6 6466.7 6472.9 6421.5 6440.0 6453.8 6486.6 6506.1 6314.4 6419.5 6428.1 6431.4 6512.4 6447.3 6469.9 6475.5 6509.3 6525.7 6265.7 6286.2 6309.2 6329.1 6368.9 04:11:00 INFO - PID 30894 | 04:11:00 INFO - PID 30894 | [#5] yui.html Cycles:180 Average:22202.64 Median:20211.34 stddev:30254.86 (149.7%) stddev-sans-first:30297.12 04:11:00 INFO - PID 30894 | Values: 816.6 822.2 834.4 843.8 858.9 17703.5 18118.2 18128.7 19671.4 20987.2 17476.0 17553.6 17565.6 17575.9 17701.9 967.7 985.9 991.4 991.6 993.0 976.1 996.8 1006.0 1007.7 1010.3 1055.7 1067.2 1067.7 1067.8 1068.0 1037.8 1041.9 1044.8 1045.4 1046.0 761.4 762.5 768.0 768.3 769.9 17910.0 18078.9 18205.8 18211.9 19072.0 17778.6 18700.8 18921.5 18967.8 19061.8 15182.9 15275.1 15278.2 15299.2 15301.9 3331.6 3355.4 3355.8 3369.8 3378.0 96157.0 96459.0 96768.5 97689.0 98443.0 14020.9 14244.8 14418.4 14570.9 14624.0 25952.7 27319.9 27535.2 27580.0 27597.7 7491.7 8187.0 8333.5 8361.5 8410.5 3780.4 3787.3 3809.6 3876.3 3910.6 3911.4 3922.5 3962.2 3981.9 4119.3 810.0 825.9 829.9 836.1 836.5 699.1 717.6 719.5 721.5 726.7 11183.6 11818.3 12844.9 13176.5 13377.7 714.9 715.5 718.9 725.7 732.5 5387.7 5737.5 5758.3 5831.3 5861.9 116653.4 116899.0 118152.0 118320.0 123125.4 98641.0 99278.0 100416.5 101488.5 102928.0 85901.0 88332.6 88487.1 89524.6 91012.5 10673.4 10693.5 11056.7 11472.4 11586.9 38127.8 38426.0 38454.0 38636.4 39938.4 49433.0 49529.0 49881.0 50440.5 51404.0 15370.8 15617.3 16028.8 16117.3 16196.7 17890.5 20751.3 21388.7 21785.5 21817.9 17953.1 18053.5 18230.6 18343.7 18487.1 17586.6 17638.6 17728.6 17982.2 18287.7 18187.5 18565.3 18607.4 18803.1 19040.5 11986.7 12423.0 12462.0 12510.6 12651.4 13327.3 13867.6 15279.5 16001.5 16065.3 04:11:00 INFO - PID 30894 | -------- Summary: end -------- 04:11:00 INFO - PID 30894 | 04:11:01 INFO - TEST-INFO | 30894: exit 0 04:11:01 INFO - TEST-OK | dromaeo_css | took 1140596ms 04:11:01 INFO - TEST-START | kraken 04:11:01 INFO - operating with platform_type : linux_ 04:11:01 INFO - Initialising browser for kraken test... 04:11:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45644/getInfo.html -profile /tmp/tmp9tuhS7/profile 04:11:01 INFO - TEST-INFO | started process 31310 (/builds/slave/test/build/application/firefox/firefox http://localhost:45644/getInfo.html) 04:11:36 INFO - TEST-INFO | 31310: killed by SIGTERM 04:11:36 INFO - Browser initialized. 04:11:36 INFO - Running cycle 1/1 for kraken test... 04:11:36 INFO - TEST-INFO | started process 31518 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9tuhS7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:11:47 INFO - PID 31518 | RSS: Main: 182071296 04:11:47 INFO - PID 31518 | 04:11:50 INFO - PID 31518 | Cycle 1(1): loaded http://localhost:45644/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45644/tests/kraken/driver.html?testName=audio-beat-detection) 04:11:51 INFO - PID 31518 | RSS: Main: 185851904 04:11:51 INFO - PID 31518 | 04:11:53 INFO - PID 31518 | Cycle 1(1): loaded http://localhost:45644/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45644/tests/kraken/driver.html?testName=audio-dft) 04:11:54 INFO - PID 31518 | RSS: Main: 184369152 04:11:54 INFO - PID 31518 | 04:11:57 INFO - PID 31518 | Cycle 1(1): loaded http://localhost:45644/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45644/tests/kraken/driver.html?testName=audio-fft) 04:11:58 INFO - PID 31518 | RSS: Main: 179527680 04:11:58 INFO - PID 31518 | 04:12:00 INFO - PID 31518 | Cycle 1(1): loaded http://localhost:45644/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45644/tests/kraken/driver.html?testName=audio-oscillator) 04:12:00 INFO - PID 31518 | RSS: Main: 180756480 04:12:00 INFO - PID 31518 | 04:12:02 INFO - PID 31518 | Cycle 1(1): loaded http://localhost:45644/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45644/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:12:03 INFO - PID 31518 | RSS: Main: 181002240 04:12:03 INFO - PID 31518 | 04:12:06 INFO - PID 31518 | Cycle 1(1): loaded http://localhost:45644/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45644/tests/kraken/driver.html?testName=imaging-darkroom) 04:12:07 INFO - PID 31518 | RSS: Main: 182304768 04:12:07 INFO - PID 31518 | 04:12:10 INFO - PID 31518 | Cycle 1(1): loaded http://localhost:45644/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45644/tests/kraken/driver.html?testName=imaging-desaturate) 04:12:11 INFO - PID 31518 | RSS: Main: 184119296 04:12:11 INFO - PID 31518 | 04:12:13 INFO - PID 31518 | Cycle 1(1): loaded http://localhost:45644/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45644/tests/kraken/driver.html?testName=json-parse-financial) 04:12:14 INFO - PID 31518 | RSS: Main: 183529472 04:12:14 INFO - PID 31518 | 04:12:16 INFO - PID 31518 | Cycle 1(1): loaded http://localhost:45644/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45644/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:12:16 INFO - PID 31518 | RSS: Main: 183123968 04:12:16 INFO - PID 31518 | 04:12:18 INFO - PID 31518 | Cycle 1(1): loaded http://localhost:45644/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45644/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:12:18 INFO - PID 31518 | RSS: Main: 182976512 04:12:18 INFO - PID 31518 | 04:12:21 INFO - PID 31518 | Cycle 1(1): loaded http://localhost:45644/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45644/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:12:21 INFO - PID 31518 | RSS: Main: 183480320 04:12:21 INFO - PID 31518 | 04:12:24 INFO - PID 31518 | Cycle 1(1): loaded http://localhost:45644/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45644/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:12:25 INFO - PID 31518 | RSS: Main: 182362112 04:12:25 INFO - PID 31518 | 04:12:28 INFO - PID 31518 | Cycle 1(1): loaded http://localhost:45644/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45644/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:12:28 INFO - PID 31518 | RSS: Main: 183062528 04:12:28 INFO - PID 31518 | 04:12:30 INFO - PID 31518 | Cycle 1(1): loaded http://localhost:45644/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45644/tests/kraken/driver.html?testName=ai-astar) 04:12:30 INFO - PID 31518 | RSS: Main: 184713216 04:12:30 INFO - PID 31518 | 04:12:30 INFO - PID 31518 | __start_tp_report 04:12:30 INFO - PID 31518 | _x_x_mozilla_page_load 04:12:30 INFO - PID 31518 | _x_x_mozilla_page_load_details 04:12:30 INFO - PID 31518 | |i|pagename|runs| 04:12:30 INFO - PID 31518 | |0;ai-astar;100;107;109;110;110;110;108;110;109;108 04:12:30 INFO - PID 31518 | |1;audio-beat-detection;144;117;121;173;120;118;119;120;140;117 04:12:30 INFO - PID 31518 | |2;audio-dft;162;164;163;162;161;162;163;165;169;175 04:12:30 INFO - PID 31518 | |3;audio-fft;73;73;73;97;73;71;73;73;97;76 04:12:30 INFO - PID 31518 | |4;audio-oscillator;87;83;104;86;80;81;92;82;83;105 04:12:30 INFO - PID 31518 | |5;imaging-gaussian-blur;117;119;116;114;113;114;113;114;114;113 04:12:30 INFO - PID 31518 | |6;imaging-darkroom;148;148;148;152;151;148;149;148;148;149 04:12:30 INFO - PID 31518 | |7;imaging-desaturate;94;95;94;94;94;94;94;95;94;94 04:12:30 INFO - PID 31518 | |8;json-parse-financial;47;48;49;49;49;50;53;53;49;49 04:12:30 INFO - PID 31518 | |9;json-stringify-tinderbox;55;55;54;54;55;55;55;55;55;54 04:12:30 INFO - PID 31518 | |10;stanford-crypto-aes;86;87;86;88;86;87;89;90;118;92 04:12:30 INFO - PID 31518 | |11;stanford-crypto-ccm;130;125;123;122;125;122;124;126;127;125 04:12:30 INFO - PID 31518 | |12;stanford-crypto-pbkdf2;179;180;185;184;171;185;187;184;184;182 04:12:30 INFO - PID 31518 | |13;stanford-crypto-sha256-iterative;65;67;65;64;71;69;65;64;62;66 04:12:30 INFO - PID 31518 | __end_tp_report 04:12:30 INFO - PID 31518 | __start_cc_report 04:12:30 INFO - PID 31518 | _x_x_mozilla_cycle_collect,885 04:12:30 INFO - PID 31518 | __end_cc_report 04:12:30 INFO - PID 31518 | __startTimestamp1496488350563__endTimestamp 04:12:30 INFO - PID 31518 | 04:12:30 INFO - PID 31518 | ------- Summary: start ------- 04:12:30 INFO - PID 31518 | Number of tests: 14 04:12:30 INFO - PID 31518 | 04:12:30 INFO - PID 31518 | [#0] ai-astar Cycles:10 Average:108.10 Median:109.50 stddev:3.03 (2.8%) stddev-sans-first:1.12 04:12:30 INFO - PID 31518 | Values: 100.0 107.0 109.0 110.0 110.0 110.0 108.0 110.0 109.0 108.0 04:12:30 INFO - PID 31518 | 04:12:30 INFO - PID 31518 | [#1] audio-beat-detection Cycles:10 Average:128.90 Median:120.50 stddev:18.31 (15.2%) stddev-sans-first:18.59 04:12:30 INFO - PID 31518 | Values: 144.0 117.0 121.0 173.0 120.0 118.0 119.0 120.0 140.0 117.0 04:12:30 INFO - PID 31518 | 04:12:30 INFO - PID 31518 | [#2] audio-dft Cycles:10 Average:164.60 Median:163.50 stddev:4.30 (2.6%) stddev-sans-first:4.46 04:12:30 INFO - PID 31518 | Values: 162.0 164.0 163.0 162.0 161.0 162.0 163.0 165.0 169.0 175.0 04:12:30 INFO - PID 31518 | 04:12:30 INFO - PID 31518 | [#3] audio-fft Cycles:10 Average:77.90 Median:73.00 stddev:10.14 (13.9%) stddev-sans-first:10.60 04:12:30 INFO - PID 31518 | Values: 73.0 73.0 73.0 97.0 73.0 71.0 73.0 73.0 97.0 76.0 04:12:30 INFO - PID 31518 | 04:12:30 INFO - PID 31518 | [#4] audio-oscillator Cycles:10 Average:88.30 Median:83.00 stddev:9.21 (11.1%) stddev-sans-first:9.76 04:12:30 INFO - PID 31518 | Values: 87.0 83.0 104.0 86.0 80.0 81.0 92.0 82.0 83.0 105.0 04:12:30 INFO - PID 31518 | 04:12:30 INFO - PID 31518 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:114.00 stddev:2.00 (1.8%) stddev-sans-first:1.94 04:12:30 INFO - PID 31518 | Values: 117.0 119.0 116.0 114.0 113.0 114.0 113.0 114.0 114.0 113.0 04:12:30 INFO - PID 31518 | 04:12:30 INFO - PID 31518 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:148.50 stddev:1.45 (1.0%) stddev-sans-first:1.50 04:12:30 INFO - PID 31518 | Values: 148.0 148.0 148.0 152.0 151.0 148.0 149.0 148.0 148.0 149.0 04:12:30 INFO - PID 31518 | 04:12:30 INFO - PID 31518 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:12:30 INFO - PID 31518 | Values: 94.0 95.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 94.0 04:12:30 INFO - PID 31518 | 04:12:30 INFO - PID 31518 | [#8] json-parse-financial Cycles:10 Average:49.60 Median:49.00 stddev:1.96 (4.0%) stddev-sans-first:1.83 04:12:30 INFO - PID 31518 | Values: 47.0 48.0 49.0 49.0 49.0 50.0 53.0 53.0 49.0 49.0 04:12:30 INFO - PID 31518 | 04:12:30 INFO - PID 31518 | [#9] json-stringify-tinderbox Cycles:10 Average:54.70 Median:55.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 04:12:30 INFO - PID 31518 | Values: 55.0 55.0 54.0 54.0 55.0 55.0 55.0 55.0 55.0 54.0 04:12:30 INFO - PID 31518 | 04:12:30 INFO - PID 31518 | [#10] stanford-crypto-aes Cycles:10 Average:90.90 Median:87.50 stddev:9.72 (11.1%) stddev-sans-first:10.15 04:12:30 INFO - PID 31518 | Values: 86.0 87.0 86.0 88.0 86.0 87.0 89.0 90.0 118.0 92.0 04:12:30 INFO - PID 31518 | 04:12:30 INFO - PID 31518 | [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:125.00 stddev:2.42 (1.9%) stddev-sans-first:1.73 04:12:30 INFO - PID 31518 | Values: 130.0 125.0 123.0 122.0 125.0 122.0 124.0 126.0 127.0 125.0 04:12:30 INFO - PID 31518 | 04:12:30 INFO - PID 31518 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.10 Median:184.00 stddev:4.58 (2.5%) stddev-sans-first:4.72 04:12:30 INFO - PID 31518 | Values: 179.0 180.0 185.0 184.0 171.0 185.0 187.0 184.0 184.0 182.0 04:12:30 INFO - PID 31518 | 04:12:30 INFO - PID 31518 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:65.50 stddev:2.62 (4.0%) stddev-sans-first:2.76 04:12:30 INFO - PID 31518 | Values: 65.0 67.0 65.0 64.0 71.0 69.0 65.0 64.0 62.0 66.0 04:12:30 INFO - PID 31518 | -------- Summary: end -------- 04:12:30 INFO - PID 31518 | 04:12:31 INFO - TEST-INFO | 31518: exit 0 04:12:31 INFO - TEST-OK | kraken | took 89972ms 04:12:31 INFO - SUITE-END | took 1230s 04:12:31 INFO - Completed test suite (00:20:30) 04:12:31 INFO - javascript benchmark 04:12:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7929.854044987054, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3287.7041066304014, 3296.1430028192676, 3302.7853189542684, 3308.9669103308966, 3341.298327351256, 5794.304683437993, 5852.297724273088, 5861.17943487912, 5873.0, 5889.411058894114, 5818.709064546777, 5852.736626851792, 5926.614770039955, 5929.614575052618, 5946.494547963417, 4897.510248975092, 5192.896142077157, 5212.192110222922, 5238.607104467161, 5244.160934250521, 5287.920681189786, 5345.679259244458, 5347.278117454132, 5351.652142610717, 5376.059189641816, 5230.843074707784, 5243.213517972296, 5270.39390470097, 5273.6572122811895, 5281.102212623844, 5288.391834938954, 5288.867778305535, 5298.894022119574, 5313.734313284359, 5347.59893008022, 5215.843524694265, 5248.0, 5266.578673706094, 5269.1569348903995, 5278.841634750964, 5776.104703770922, 5834.095715164156, 5887.411258874121, 5896.0, 5906.763729450817, 6356.173697419306, 6375.968120159416, 6388.776392826276, 6389.6805159741825, 6400.615963042233, 6444.903326450107, 6446.387593178641, 6447.355264473562, 6453.903191452132, 6460.773872914426, 5852.122181672783, 5944.851378715523, 5975.073863551156, 5976.999999999956, 5978.730957106941, 6417.743290268337, 6427.55007149495, 6440.645764482904, 6503.0, 6513.706883190268, 6121.117656725397, 6210.50315974721, 6237.563370564108, 6238.157848690459, 6284.057391391328, 6260.436560709558, 6328.7468501260355, 6329.841753956188, 6338.271098823602, 6344.0, 6300.59046161998, 6313.779017734358, 6316.115743795872, 6318.494520438354, 6338.334474880071, 6187.133801267826, 6283.717232724538, 6301.96849015752, 6322.810315690536, 6381.4575761059905, 4866.31871537985, 4868.342773725572, 4874.147024270738, 4888.755562221874, 4914.0, 4308.375285583636, 4316.546762589883, 4320.135972805451, 4332.068605249887, 4369.541198174146, 5892.116182572563, 5944.881102377928, 5955.3151387590115, 5960.225170727865, 6001.969990150022, 6298.08677741734, 6321.525885558602, 6342.04869269604, 6355.841103972345, 6411.743530258737, 5923.703814809242, 5923.911141332884, 5925.259342582177, 5933.525317974551, 5974.761009559569, 5325.0, 5373.435789242073, 5384.0847056000575, 5388.7305634718105, 5390.460953904657, 6343.27052388972, 6420.775272865428, 6553.705083271169, 6596.307387724316, 6630.53586248958, 6368.36316368378, 6377.1390862233, 6379.425851673372, 6382.234131904202, 6392.0, 6597.637129957899, 6602.570832895846, 6606.9008964866525, 6610.338966103352, 6614.669266536558, 6182.443580077815, 6227.626342419469, 6232.283287422005, 6268.623882567061, 6308.589941653778, 6303.936960630335, 6313.842153946004, 6327.936720632735, 6337.524685648503, 6347.238331400262, 6093.847653808691, 6126.172966649624, 6128.050152226412, 6128.105930682507, 6150.569460137747, 6132.4166970161305, 6147.047207682816, 6269.404406581368, 6270.655113968775, 6289.433950944437, 6273.498120150468, 6276.6547839869245, 6303.621782693053, 6311.747530098744, 6314.273858506331, 6295.496360291258, 6336.714847831767, 6356.682165891594, 6362.268339141058, 6365.90451143224, 6070.605410648471, 6084.14821924922, 6111.04482360895, 6120.90429240112, 6169.56813023084], "value": 5816.63102326921, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.384790612402, 739.3087463221888, 756.1644382956835, 1080.292408472451, 1097.0839349143464, 35728.64271357286, 36303.63696363036, 36429.27141457169, 36604.99999999996, 36612.63387366125, 38239.23521529575, 38501.422478662775, 38513.614863851355, 38516.0, 38610.22779544407, 7056.0, 7088.503804733684, 7188.173360063581, 7189.748358807443, 7228.566286022829, 6601.306862779411, 6611.371919667624, 6614.570052946568, 6616.139901812758, 6625.536212465106, 6588.868222635544, 6595.571287866273, 6640.966795166041, 6641.269460359356, 6647.50143739219, 6594.241662208859, 6609.867802643968, 6611.636360000198, 6623.668816559153, 6626.0, 7158.427325813923, 7169.103862017248, 7179.856402871966, 7183.676734546906, 7195.6042417667, 35510.467342989876, 35525.28949421023, 35602.465963010574, 35635.28729425397, 35643.64356356429, 3433.4163192257374, 3440.397930362177, 3442.1394651337164, 3467.7052450541732, 3473.531073305097, 28120.437591248265, 28146.718532814615, 28194.295142621395, 28232.576511352345, 28272.15183544497, 3489.162600975773, 3568.2506673598577, 3586.7309951753464, 3587.4798154267746, 3631.346357655621, 163296.18351908165, 164047.0, 179294.0, 198939.0, 201490.0, 42568.0, 42730.57269427328, 42848.92877678083, 43070.0, 43086.56913430826, 44367.33448998268, 44508.0, 44681.55318446774, 44688.3296750549, 44874.0, 14035.78946315806, 14083.85916140846, 14109.153450792985, 14123.858761412459, 14173.645658858404, 11486.94256528712, 11501.0, 11560.768784624428, 11564.0, 11573.132015098901, 13221.405036773369, 13507.0, 13529.59411217665, 13614.591562253148, 13629.795553066711, 5627.943720562742, 5671.858203544944, 5711.228984087095, 5766.654000759968, 5810.448007439287, 1047.4762618690654, 1053.8788039375418, 1063.728749168957, 1070.946452677363, 1071.566015763617, 23216.53566928686, 24798.87600562022, 25386.619200712004, 25410.74589254084, 25534.616980745304, 1125.9718507037226, 1144.722003213599, 1151.113642495274, 1152.504423098076, 1198.6583823610229, 12231.266124032409, 16625.08562029076, 16980.830191697925, 17216.569585760455, 17254.309827607005, 257060.0, 258555.0, 258993.0, 259470.0, 259964.0, 50583.49416505788, 54626.72686636541, 54826.17760733592, 54968.45031549713, 55004.72497637566, 1431.8496557861483, 1469.0818238600875, 1482.0292708276097, 1486.3980088064136, 1495.827979782339, 26234.606480903185, 29439.0, 29930.551041733957, 30204.395912081196, 30260.69739302579, 37324.0, 37532.437013445364, 37600.2479950394, 37628.623713762514, 37802.2439551202, 221255.0, 221728.0, 222341.0, 222425.0, 222724.0, 32450.18874528061, 32517.837410812794, 32530.837345814067, 33761.49357759685, 33878.830605846815, 40818.79590602028, 41914.0, 42283.36574951317, 42377.78811105925, 42591.3611295837, 29036.419271614872, 29585.408291833613, 30100.247493811952, 30625.0, 32658.0, 29808.254793630334, 30607.0, 30781.846090769403, 32545.186370340933, 32605.347893041533, 35832.4625130618, 36219.27561448704, 36653.26693466063, 36668.44997325096, 37137.0715732098, 27918.0, 28982.07304758154, 29706.851465742533, 30674.693253067184, 31759.0, 24549.63175552404, 25716.485670286114, 25806.35484112837, 25832.612510811978, 26237.212883613523], "value": 16625.13429056205, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [445.3342253331268, 452.6650278793693, 453.1164229751984, 469.19064613541633, 471.98820029499257, 19841.305554305603, 20943.266985655486, 20950.057247423865, 22530.77469225307, 23374.41563960902, 23658.408539786513, 24087.518249634995, 24159.879200604017, 24169.637455438184, 24244.27267181983, 5601.159826026098, 5676.659400435987, 5689.089745640677, 5712.171735098408, 5717.113847353667, 5601.523870471015, 5625.8593535161535, 5644.04051311276, 5645.350784659776, 5663.546916246691, 5530.861728456801, 5638.267025286707, 5745.023346031185, 5764.702941838094, 5784.768609255646, 5707.971460142714, 5728.885422291552, 5734.168545560912, 5748.885022299552, 5749.511291540203, 5214.895702085975, 5217.8173763918085, 5218.373795144569, 5234.8691282717855, 5238.842834714965, 26437.0, 26863.194104176906, 26925.0, 26950.865245673645, 27030.459390812073, 2068.369147410039, 2152.2359562355296, 2168.642174041281, 2168.6530155175255, 2177.3032629558547, 18204.45386638403, 18423.526117910536, 18477.353292634692, 18533.536661583432, 18604.906975465172, 2192.903548225887, 2272.863628182314, 2296.908123675051, 2298.931032069024, 2301.7583153768783, 121452.0, 122335.38832305871, 130202.34898825445, 130294.0, 130317.0, 12548.749025019448, 13138.211707297593, 13228.206307621573, 13235.27206003679, 13307.205486847677, 18360.90819545894, 18467.353642622445, 18510.16704248312, 18510.629787404447, 18601.7209741854, 8731.956340218258, 9316.487593182304, 9493.288003399635, 9710.077542633438, 9744.220462362993, 8812.515311657791, 9000.549972501349, 9020.729378118667, 9083.636654533877, 9131.634734610674, 8325.417220794487, 8431.704890328809, 8449.112843151504, 8470.15298470148, 8549.187827156411, 2265.546890621882, 2313.9652905206435, 2344.3318654183477, 2365.8107351411845, 2483.081259933836, 943.8253923024263, 974.2303580171726, 979.5738853598565, 989.248171389749, 1026.553449249564, 18846.811531884505, 18932.836638544955, 19429.80570194308, 20028.89985550092, 20121.295754648516, 1006.9798604027878, 1024.3469414217213, 1039.4387031003173, 1045.8012977534245, 1071.6249312740479, 10724.78550428987, 10850.535177750902, 11014.173936954761, 11444.427778611036, 11464.254823436617, 438982.0, 445417.0, 450249.0, 451704.0, 457498.0, 97204.0, 98538.50730746443, 98828.50585747026, 99236.50381748189, 100401.49799251102, 1175.5004123247757, 1195.8146487294484, 1255.8555766087018, 1256.0830593666492, 1256.7298030923396, 19299.614007720047, 20702.689459658417, 21809.0, 21909.67135492937, 21932.0, 51082.489175107774, 51486.74256628693, 53028.46971530235, 53238.20142697785, 53300.73349633382, 64663.67668161629, 64948.0, 65135.0, 65296.0, 66105.33894661184, 10875.40185289785, 11173.27373720738, 11190.32858028521, 11195.38425386579, 11242.10063194926, 17981.55046123805, 18097.36659216921, 18110.81889181091, 18357.632847342713, 18407.81592184061, 14359.256297481092, 15893.841061589235, 15955.441559545361, 16065.357385704909, 16205.108719020567, 12917.935410322889, 13280.734385312433, 13459.596212113653, 13638.181709097486, 13784.379702913593, 15106.697866042838, 15284.312205950537, 15390.384384624938, 15429.691406172038, 15438.30527626282, 10982.615608453665, 11009.504572294105, 11009.61466348674, 11072.557097716, 11094.500747466222, 14874.628134296296, 15014.549563513112, 15062.32219550101, 15473.5357939262, 15474.690506190038], "value": 10790.680735460553, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.155701907798, 1396.7485852546545, 1398.9088510961453, 1407.7888316752485, 1407.9929600351998, 11743.003689372807, 11874.703132421671, 12174.817377739319, 12270.509179632814, 12437.751244975096, 11936.94031529841, 12065.879341206586, 12157.817632735516, 12164.513419463234, 12164.756704865897, 2100.0864623888583, 2165.1447678167115, 2175.2386664667397, 2176.836737244705, 2181.018541656253, 2172.435166856613, 2225.9666105008437, 2228.43174990378, 2245.057076028064, 2246.3934737620834, 2194.6049711052005, 2199.6480563109903, 2202.757696653367, 2221.7111775469166, 2223.2552095048177, 2173.89130543473, 2183.7816218378193, 2184.683220932956, 2187.5406164705432, 2203.7575866654734, 2077.6987336836223, 2110.4196346004974, 2115.640341141994, 2120.8091271785615, 2125.1393185759794, 11815.704607384798, 11984.101192410604, 12009.399530023464, 12037.0, 12048.216865903689, 6484.383983521605, 6615.636140012298, 6669.666516674195, 6677.065210870482, 6700.162479690039, 3861.362875125629, 3943.397357743875, 3985.262726395626, 4035.9192816143805, 4072.6334629883454, 1292.3473645808901, 1313.5862203405898, 1314.7436249931268, 1315.5987423835727, 1337.6321511584392, 18604.720929186074, 18717.62564748711, 18752.156152973148, 18759.906200469046, 19344.516387090436, 5299.178627312773, 5322.042032434199, 5347.518723314843, 5394.91907621386, 5491.450854914477, 13779.379927903268, 13789.379477923518, 13806.240656763974, 13852.030357875054, 13897.16617002983, 6453.515986301046, 6545.410913017756, 6545.934540654533, 6561.475081993429, 6567.507436942248, 6048.243969503812, 6059.0, 6117.908231376533, 6130.632162070201, 6162.568620196544, 4185.874423767292, 4278.572142785696, 4292.077203401283, 4340.978295108504, 4370.8033138508845, 1234.530878266271, 1248.1076030637955, 1263.1473755215193, 1267.4296566545092, 1276.1577358943052, 888.5379602606738, 910.4355299714219, 919.7930465645177, 931.8322701913585, 933.3513208320152, 6931.89602155958, 7663.0, 7718.228177182237, 7959.084705258853, 8033.6786528538205, 993.3841018568534, 1017.7786656012814, 1025.0723095598496, 1027.9743006424899, 1048.0933992096782, 4781.784819683123, 4885.76274568491, 5088.567471764867, 5376.892462150735, 5397.78408863641, 15425.537233883002, 16426.096564688818, 16522.173891305385, 16804.74792878108, 16826.915865420593, 15649.139297338528, 15820.129892855774, 16006.0, 16047.598810029842, 16048.0, 9091.954540227389, 9314.254859611216, 9316.301277404222, 9498.0, 9983.201343892471, 7459.925400745923, 7767.417443691633, 7791.64937577799, 7830.960845195737, 8274.29668478186, 14026.929865351016, 14052.437902483785, 14093.083949543246, 14217.289135542975, 14547.563573092824, 14347.354369053626, 14364.712705746035, 14452.566423007327, 14522.85477145215, 14713.92643036778, 10013.24900632441, 10135.290529662852, 10143.391396515937, 10245.180385568987, 10274.0, 11178.664640060812, 11235.213535052468, 11375.943120284346, 11417.31496110236, 11426.885731142582, 9255.67605133817, 9477.952610236905, 9536.046395360408, 9636.951815240878, 9712.951435242778, 9182.632694692138, 9370.718878433658, 9426.764330891783, 9448.763780905258, 9723.173530250007, 8365.288950439037, 8504.064552899299, 8519.318454523747, 8536.359773016924, 8538.914610853812, 6132.601380910227, 6560.901586476302, 6591.373819487141, 6892.551984121016, 7091.43268538526, 6704.094947182068, 6717.395434410926, 6964.094667693167, 6971.163460384786, 7237.312455316736], "value": 5575.4087214172705, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.1418669753842, 430.79537219820577, 437.45536806675693, 439.89222640453113, 442.47787610619457, 6033.69831508425, 6143.692815359236, 6186.597871138379, 6197.0, 6241.563090583655, 5914.9112763308585, 6039.456448919596, 6039.939600603992, 6046.3349031606485, 6058.575899687013, 4574.9542504574865, 4659.9534004659945, 4676.181668208067, 4683.227267500875, 4684.672072954894, 4688.695234809744, 4689.9531004690025, 4704.341392205077, 4718.952810471886, 4719.811207551694, 4659.0, 4661.44062712475, 4669.2062349400685, 4692.577668009879, 4702.764861756916, 4688.789004494806, 4700.318453824177, 4702.27114797207, 4702.365180700596, 4702.388689470347, 4151.066010147722, 4152.252594532983, 4167.166566686675, 4167.83328666853, 4171.311733563958, 5953.196318496991, 5987.37132601075, 6018.127371531104, 6029.668368239745, 6044.214252147237, 5513.255710479074, 5534.557235421156, 5543.085390910495, 5547.807221447368, 5554.222408862763, 6486.870262594722, 6488.480921526267, 6500.512461565354, 6525.869482610321, 6529.706163222619, 4678.649101317381, 4684.95315046852, 4686.273627587695, 4689.320048592935, 4692.882677933045, 6400.839979000516, 6750.459963202981, 6752.493562982796, 6810.182778066614, 6844.178698556156, 4673.742944138037, 4744.383230180124, 4747.0299825572, 4750.691205071659, 4763.1426343258545, 4776.47458779534, 4794.664373493822, 4805.975970120127, 4807.735574543363, 4836.516348365206, 5343.0, 5450.155225939986, 5494.120940649477, 5499.752511137009, 5508.889822203533, 6458.483321334282, 6492.285848556655, 6492.480601551959, 6509.121268628769, 6529.967350163219, 1657.9088150151858, 1659.8008239011397, 1666.275170300923, 1670.13987796285, 1675.3633619224618, 1115.252780636975, 1134.1040577943331, 1154.6132045764596, 1156.6183159557327, 1161.0653423993597, 6146.555559443527, 6147.877042459126, 6175.9073613894925, 6185.783497577563, 6192.752289908353, 6630.403263706193, 6639.800805975829, 6664.900026499607, 6668.633225172662, 6699.497537684693, 6099.939000610026, 6125.0, 6129.0, 6161.568690191643, 6171.537134714914, 3494.545709057806, 3517.9472307915403, 3533.840977156034, 3535.5403797506674, 3561.1097225693575, 6866.279040700754, 6902.861942761117, 6908.378245957888, 6918.792436226921, 6922.376986071177, 6752.493562982698, 6811.625360605214, 6818.215905170969, 6830.146231721035, 6845.965770171118, 6831.8138195777865, 6893.620850853151, 6925.965370173117, 6943.270956549591, 6957.234704182536, 6611.834704132243, 6643.368879956396, 6665.733370665119, 6669.566043300713, 6710.698018589078, 6571.737130514726, 6637.336266373324, 6642.335766423319, 6646.966765166143, 6651.667416629246, 6569.2263088966665, 6875.209350924708, 6882.311768823078, 6914.204866440223, 6917.342852429011, 4724.433068031858, 4737.905241895074, 4766.976165119152, 4769.73766442849, 4780.11567859947, 6492.610443373413, 6619.933800661932, 6624.536282460374, 6692.83267918306, 6710.731570737116, 6434.940818937895, 6451.935480645134, 6459.644719540471, 6466.741330346922, 6472.935270647422, 6421.454176395058, 6440.035789084374, 6453.806045881527, 6486.610803351814, 6506.089147519446, 6314.400131987454, 6419.4864410846085, 6428.100065990859, 6431.421172094534, 6512.413882750575, 6447.258565265054, 6469.902951455638, 6475.546711730133, 6509.286495502844, 6525.673716314261, 6265.686715664289, 6286.214223222098, 6309.242890852944, 6329.1139240505445, 6368.87262254743], "value": 4951.695334559235, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [816.6488409983712, 822.169608695218, 834.4159088637953, 843.8017065989492, 858.8883445152129, 17703.46889593311, 18118.184681689338, 18128.728069078974, 19671.409857704257, 20987.160513579478, 17476.0, 17553.56116097098, 17565.560860978483, 17575.91212043941, 17701.91149044253, 967.7048500207452, 985.8816941966974, 991.3853410885262, 991.6281394477071, 993.0, 976.0629795396393, 996.7707427291691, 1006.0342071611262, 1007.6876168387787, 1010.2927950434688, 1055.6938487838518, 1067.215596536549, 1067.743741502038, 1067.7757670889123, 1067.9893201068007, 1037.766502536923, 1041.9114375278111, 1044.780596074825, 1045.3936716704332, 1045.9529321180528, 761.4213197969527, 762.4624639629104, 767.9769606911801, 768.3353898877431, 769.9230076992256, 17910.0, 18078.90960545202, 18205.817941820544, 18211.908940455345, 19072.0, 17778.644427111387, 18700.812991870043, 18921.526961826065, 18967.81032189674, 19061.809381906143, 15182.924085379613, 15275.083494990226, 15278.236088195657, 15299.15854627995, 15301.923490382587, 3331.6335203127637, 3355.446351352024, 3355.7818741781707, 3369.8146601936883, 3377.9662203378143, 96157.0, 96459.0, 96768.51615741877, 97689.0, 98443.0, 14020.85979140216, 14244.786328204878, 14418.351174197187, 14570.927145364205, 14624.049436786787, 25952.74047259541, 27319.863400683265, 27535.173944781687, 27580.0, 27597.724022759514, 7491.66287517063, 8186.959065204755, 8333.458325208841, 8361.456505327256, 8410.453320534145, 3780.3762379207124, 3787.299349620329, 3809.6380843819793, 3876.3022655922205, 3910.550286717064, 3911.3546264866545, 3922.490076290064, 3962.167944731581, 3981.8606348777653, 4119.258533464005, 809.9919000809916, 825.859603867344, 829.8796674482167, 836.0719601242616, 836.5315423362814, 699.1435491522844, 717.6340066566089, 719.4675939804507, 721.5237942957623, 726.7202127181073, 11183.608573699881, 11818.290902545874, 12844.935775321064, 13176.538821141214, 13377.73244535104, 714.9285071492809, 715.5134508534143, 718.8741970155202, 725.7496163823578, 732.5018987088724, 5387.676739395649, 5737.479567914506, 5758.330084275597, 5831.329397119301, 5861.912071318934, 116653.4167329175, 116899.0, 118152.0, 118320.0, 123125.38437307936, 98641.0, 99278.0, 100416.49791751141, 101488.49255753674, 102928.0, 85901.0, 88332.64356697258, 88487.11512884918, 89524.552377239, 91012.54493727621, 10673.35959842412, 10693.465326733476, 11056.723581910517, 11472.426378681199, 11586.88413115858, 38127.80936095302, 38426.0, 38454.0, 38636.420453692655, 39938.400923986745, 49433.0, 49529.0, 49881.0, 50440.49559504358, 51404.0, 15370.846291536942, 15617.297221624827, 16028.759568606247, 16117.274722637743, 16196.67606647884, 17890.463286101436, 20751.27370542084, 21388.679169812152, 21785.455363616038, 21817.890910545346, 17953.102344882966, 18053.548661283574, 18230.635387292445, 18343.724844127617, 18487.075646217367, 17586.560335991704, 17638.647227055644, 17728.55678608045, 17982.190801413704, 18287.725684115016, 18187.545311366794, 18565.25738970426, 18607.44177674672, 18803.05984700787, 19040.52398690044, 11986.700332491757, 12423.0, 12462.0, 12510.624681259576, 12651.367431628198, 13327.267000315076, 13867.583972480841, 15279.541613751606, 16001.519954401387, 16065.27706253198], "value": 8630.712924022722, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1493.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 107.0, 109.0, 110.0, 110.0, 110.0, 108.0, 110.0, 109.0, 108.0], "value": 108.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 117.0, 121.0, 173.0, 120.0, 118.0, 119.0, 120.0, 140.0, 117.0], "value": 128.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 163.0, 162.0, 161.0, 162.0, 163.0, 165.0, 169.0, 175.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 97.0, 73.0, 71.0, 73.0, 73.0, 97.0, 76.0], "value": 77.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 104.0, 86.0, 80.0, 81.0, 92.0, 82.0, 83.0, 105.0], "value": 88.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 116.0, 114.0, 113.0, 114.0, 113.0, 114.0, 114.0, 113.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 152.0, 151.0, 148.0, 149.0, 148.0, 148.0, 149.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 48.0, 49.0, 49.0, 49.0, 50.0, 53.0, 53.0, 49.0, 49.0], "value": 49.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 54.0, 55.0, 55.0, 55.0, 55.0, 55.0, 54.0], "value": 54.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 86.0, 88.0, 86.0, 87.0, 89.0, 90.0, 118.0, 92.0], "value": 90.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 125.0, 123.0, 122.0, 125.0, 122.0, 124.0, 126.0, 127.0, 125.0], "value": 124.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 180.0, 185.0, 184.0, 171.0, 185.0, 187.0, 184.0, 184.0, 182.0], "value": 182.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 65.0, 64.0, 71.0, 69.0, 65.0, 64.0, 62.0, 66.0], "value": 65.8, "unit": "score"}]}]} 04:12:31 INFO - Return code: 0 04:12:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:12:31 INFO - # TBPL SUCCESS # 04:12:31 INFO - Running post-action listener: _resource_record_post_action 04:12:31 INFO - [mozharness: 2017-06-03 11:12:31.940564Z] Finished run-tests step (success) 04:12:31 INFO - Running post-run listener: _resource_record_post_run 04:12:32 INFO - Total resource usage - Wall time: 1248s; CPU: 13.0%; Read bytes: 12288; Write bytes: 420417536; Read time: 260; Write time: 263664 04:12:32 INFO - TinderboxPrint: CPU usage
12.6% 04:12:32 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 260 04:12:32 INFO - TinderboxPrint: I/O write bytes / time
420,417,536 / 263,664 04:12:32 INFO - TinderboxPrint: CPU idle
8,705.3 (87.4%) 04:12:32 INFO - TinderboxPrint: CPU user
1,204.0 (12.1%) 04:12:32 INFO - TinderboxPrint: Swap in / out
0 / 0 04:12:32 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 99250176; Read time: 68; Write time: 84560 04:12:32 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:12:32 INFO - run-tests - Wall time: 1231s; CPU: 13.0%; Read bytes: 4096; Write bytes: 316514304; Read time: 180; Write time: 178656 04:12:32 INFO - Running post-run listener: _upload_blobber_files 04:12:32 INFO - Blob upload gear active. 04:12:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:12:32 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 04:12:32 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'] 04:12:32 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 04:12:33 INFO - (blobuploader) - INFO - Open directory for files ... 04:12:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:12:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:12:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:12:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:33 INFO - (blobuploader) - INFO - Done attempting. 04:12:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:12:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:12:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:12:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:34 INFO - (blobuploader) - INFO - Done attempting. 04:12:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:12:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:12:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:12:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:35 INFO - (blobuploader) - INFO - Done attempting. 04:12:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:12:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:12:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:12:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:39 INFO - (blobuploader) - INFO - Done attempting. 04:12:39 INFO - (blobuploader) - INFO - Iteration through files over. 04:12:39 INFO - Return code: 0 04:12:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:12:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:12:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c6d1fffb44ae6ddf0d696806d06ca66b0f9e4df542ea4094f8f96d01742b30914da11a4a83f4a7927e4f289eeefc9aeea44fad5264af6ae99cd6ca33168ee97c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d0b55f11cea3be71f463074d8348a3500c19bb5ab4b9f9c02f452e7e3d316fe038c10cdca254fc3ce51fa485cce7486e9686f0796528c30e3cc2ad3cc3a9c10c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/33e2f017826480e510afd55bfbd53dbc836245414f1caf7d4a4dc615beb04190529b57d40cac27f05baa5280628139eec2981cb0cbbc468c5ab15fdb7e457487", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4f9393a24f643dfcbd84c5315df1bc8b013dfe304fa0b6cdb8338a87e9c5f0cd29088d9b9fd82588c548dfbaaf0ecf288f659944099044adb84c1505d3c52e33"} 04:12:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:12:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:12:39 INFO - Contents: 04:12:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c6d1fffb44ae6ddf0d696806d06ca66b0f9e4df542ea4094f8f96d01742b30914da11a4a83f4a7927e4f289eeefc9aeea44fad5264af6ae99cd6ca33168ee97c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d0b55f11cea3be71f463074d8348a3500c19bb5ab4b9f9c02f452e7e3d316fe038c10cdca254fc3ce51fa485cce7486e9686f0796528c30e3cc2ad3cc3a9c10c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/33e2f017826480e510afd55bfbd53dbc836245414f1caf7d4a4dc615beb04190529b57d40cac27f05baa5280628139eec2981cb0cbbc468c5ab15fdb7e457487", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4f9393a24f643dfcbd84c5315df1bc8b013dfe304fa0b6cdb8338a87e9c5f0cd29088d9b9fd82588c548dfbaaf0ecf288f659944099044adb84c1505d3c52e33"} 04:12:39 INFO - Running post-run listener: copy_logs_to_upload_dir 04:12:39 INFO - Copying logs to upload dir... 04:12:39 INFO - mkdir: /builds/slave/test/build/upload/logs 04:12:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1307.141381 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 47 secs) (at 2017-06-03 04:12:37.536735) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-03 04:12:37.544172) ========= 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=6d15e502d8e29d5d2676d664000001c3-1496481317.185838-1999502738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c6d1fffb44ae6ddf0d696806d06ca66b0f9e4df542ea4094f8f96d01742b30914da11a4a83f4a7927e4f289eeefc9aeea44fad5264af6ae99cd6ca33168ee97c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d0b55f11cea3be71f463074d8348a3500c19bb5ab4b9f9c02f452e7e3d316fe038c10cdca254fc3ce51fa485cce7486e9686f0796528c30e3cc2ad3cc3a9c10c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/33e2f017826480e510afd55bfbd53dbc836245414f1caf7d4a4dc615beb04190529b57d40cac27f05baa5280628139eec2981cb0cbbc468c5ab15fdb7e457487", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4f9393a24f643dfcbd84c5315df1bc8b013dfe304fa0b6cdb8338a87e9c5f0cd29088d9b9fd82588c548dfbaaf0ecf288f659944099044adb84c1505d3c52e33"} build_url:https://queue.taskcluster.net/v1/task/Z6aQOLT8QLqJ2pnGOASq7Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011183 build_url: 'https://queue.taskcluster.net/v1/task/Z6aQOLT8QLqJ2pnGOASq7Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c6d1fffb44ae6ddf0d696806d06ca66b0f9e4df542ea4094f8f96d01742b30914da11a4a83f4a7927e4f289eeefc9aeea44fad5264af6ae99cd6ca33168ee97c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d0b55f11cea3be71f463074d8348a3500c19bb5ab4b9f9c02f452e7e3d316fe038c10cdca254fc3ce51fa485cce7486e9686f0796528c30e3cc2ad3cc3a9c10c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/33e2f017826480e510afd55bfbd53dbc836245414f1caf7d4a4dc615beb04190529b57d40cac27f05baa5280628139eec2981cb0cbbc468c5ab15fdb7e457487", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4f9393a24f643dfcbd84c5315df1bc8b013dfe304fa0b6cdb8338a87e9c5f0cd29088d9b9fd82588c548dfbaaf0ecf288f659944099044adb84c1505d3c52e33"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-03 04:12:37.573630) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-03 04:12:37.573959) ========= 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=6d15e502d8e29d5d2676d664000001c3-1496481317.185838-1999502738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004435 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-03 04:12:37.659051) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-03 04:12:37.659436) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-03 04:12:37.659870) ========= ========= Total master_lag: 0.20 =========