builder: mozilla-beta_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-064 starttime: 1495452191.61 results: success (0) revision: 053736317dff63597082150329642427c76ddc16 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-22 04:23:11.609144) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-22 04:23:11.609606) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-22 04:23:11.609872) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-22 04:23:11.643090) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-22 04:23:11.643399) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1495448663.425565-1728233154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-22 04:23:11-- 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% 226M=0s 2017-05-22 04:23:12 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.150646 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-22 04:23:11.814313) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-22 04:23:11.814621) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1495448663.425565-1728233154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018527 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-22 04:23:11.866960) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-05-22 04:23:11.867283) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 053736317dff63597082150329642427c76ddc16 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 053736317dff63597082150329642427c76ddc16 --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=a12cd81e0ef515edd9e0d800000001bb-1495448663.425565-1728233154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-22 04:23:12,144 truncating revision to first 12 chars 2017-05-22 04:23:12,144 Setting DEBUG logging. 2017-05-22 04:23:12,144 attempt 1/10 2017-05-22 04:23:12,144 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/053736317dff?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-22 04:23:13,476 unpacking tar archive at: mozilla-beta-053736317dff/testing/mozharness/ program finished with exit code 0 elapsedTime=1.999726 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-05-22 04:23:13.879886) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-22 04:23:13.880183) ========= script_repo_revision: 053736317dff63597082150329642427c76ddc16 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-22 04:23:13.880559) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-22 04:23:13.880819) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-22 04:23:13.888764) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-05-22 04:23:13.889027) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-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', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-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=a12cd81e0ef515edd9e0d800000001bb-1495448663.425565-1728233154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:23:14 INFO - MultiFileLogger online at 20170522 04:23:14 in /builds/slave/test 04:23:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 04:23:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:23:14 INFO - {'append_to_log': False, 04:23:14 INFO - 'base_work_dir': '/builds/slave/test', 04:23:14 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 04:23:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:23:14 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 04:23:14 INFO - 'buildbot_json_path': 'buildprops.json', 04:23:14 INFO - 'config_files': ('talos/linux_config.py',), 04:23:14 INFO - 'default_actions': ('clobber', 04:23:14 INFO - 'read-buildbot-config', 04:23:14 INFO - 'download-and-extract', 04:23:14 INFO - 'populate-webroot', 04:23:14 INFO - 'create-virtualenv', 04:23:14 INFO - 'install', 04:23:14 INFO - 'run-tests'), 04:23:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:23:14 INFO - 'download_minidump_stackwalk': True, 04:23:14 INFO - 'download_symbols': 'ondemand', 04:23:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:23:14 INFO - 'tooltool.py': '/tools/tooltool.py', 04:23:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:23:14 INFO - '/tools/misc-python/virtualenv.py')}, 04:23:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:23:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:23:14 INFO - 'gecko_profile': False, 04:23:14 INFO - 'gecko_profile_interval': 0, 04:23:14 INFO - 'installer_path': 'installer.exe', 04:23:14 INFO - 'log_level': 'info', 04:23:14 INFO - 'log_name': 'talos', 04:23:14 INFO - 'log_to_console': True, 04:23:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:23:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:23:14 INFO - 'opt_config_files': (), 04:23:14 INFO - 'pip_index': False, 04:23:14 INFO - 'suite': 'dromaeojs', 04:23:14 INFO - 'system_bits': '32', 04:23:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:23:14 INFO - 'title': 'talos-linux64-ix-064', 04:23:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:23:14 INFO - 'use_talos_json': True, 04:23:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:23:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:23:14 INFO - 'work_dir': 'build'} 04:23:14 INFO - [mozharness: 2017-05-22 11:23:14.267963Z] Running clobber step. 04:23:14 INFO - Running pre-action listener: _resource_record_pre_action 04:23:14 INFO - Running main action method: clobber 04:23:14 INFO - rmtree: /builds/slave/test/build 04:23:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:23:15 INFO - Running post-action listener: _resource_record_post_action 04:23:15 INFO - [mozharness: 2017-05-22 11:23:15.277204Z] Finished clobber step (success) 04:23:15 INFO - [mozharness: 2017-05-22 11:23:15.277304Z] Running read-buildbot-config step. 04:23:15 INFO - Running pre-action listener: _resource_record_pre_action 04:23:15 INFO - Running main action method: read_buildbot_config 04:23:15 INFO - Using buildbot properties: 04:23:15 INFO - { 04:23:15 INFO - "project": "", 04:23:15 INFO - "product": "firefox", 04:23:15 INFO - "who": "cbook@mozilla.com", 04:23:15 INFO - "installer_path": "public/build/target.tar.bz2", 04:23:15 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 04:23:15 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta/", 04:23:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs", 04:23:15 INFO - "stage_platform": "linux64", 04:23:15 INFO - "basedir": "/builds/slave/test", 04:23:15 INFO - "buildnumber": 50, 04:23:15 INFO - "platform": "ubuntu64_hw", 04:23:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:23:15 INFO - "slavebuilddir": "test", 04:23:15 INFO - "taskId": "bwKwmjnETlOt3aFl-zrW9A", 04:23:15 INFO - "branch": "mozilla-beta", 04:23:15 INFO - "script_repo_revision": "production", 04:23:15 INFO - "revision": "053736317dff63597082150329642427c76ddc16", 04:23:15 INFO - "slavename": "talos-linux64-ix-064", 04:23:15 INFO - "repo_path": "releases/mozilla-beta" 04:23:15 INFO - } 04:23:15 INFO - Finding installer, test and symbols from parent task. 04:23:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bwKwmjnETlOt3aFl-zrW9A'}, attempt #1 04:23:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bwKwmjnETlOt3aFl-zrW9A'}, attempt #1 04:23:16 INFO - Task dependencies: RRzistD9SHSUBwg1DW3_JQ 04:23:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RRzistD9SHSUBwg1DW3_JQ'}, attempt #1 04:23:16 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/RRzistD9SHSUBwg1DW3_JQ/artifacts/public/build/target.tar.bz2 04:23:16 INFO - Set test_url: https://queue.taskcluster.net/v1/task/RRzistD9SHSUBwg1DW3_JQ/artifacts/public/build/test_packages.json 04:23:16 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/RRzistD9SHSUBwg1DW3_JQ/artifacts/public/build/target.crashreporter-symbols.zip 04:23:16 INFO - Running post-action listener: _resource_record_post_action 04:23:16 INFO - [mozharness: 2017-05-22 11:23:16.865592Z] Finished read-buildbot-config step (success) 04:23:16 INFO - [mozharness: 2017-05-22 11:23:16.865901Z] Running download-and-extract step. 04:23:16 INFO - Running pre-action listener: _resource_record_pre_action 04:23:16 INFO - Running main action method: download_and_extract 04:23:16 INFO - mkdir: /builds/slave/test/build/tests 04:23:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:23:16 INFO - trying https://queue.taskcluster.net/v1/task/RRzistD9SHSUBwg1DW3_JQ/artifacts/public/build/target.test_packages.json 04:23:16 INFO - Downloading https://queue.taskcluster.net/v1/task/RRzistD9SHSUBwg1DW3_JQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:23:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RRzistD9SHSUBwg1DW3_JQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:23:17 INFO - Downloaded 986 bytes. 04:23:17 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:23:17 INFO - Using the following test package requirements: 04:23:17 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:23:17 INFO - u'common': [u'target.common.tests.zip'], 04:23:17 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:23:17 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:23:17 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:23:17 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:23:17 INFO - u'mozbase': [u'target.common.tests.zip'], 04:23:17 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:23:17 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:23:17 INFO - u'web-platform': [u'target.common.tests.zip', 04:23:17 INFO - u'target.web-platform.tests.zip'], 04:23:17 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:23:17 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:23:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RRzistD9SHSUBwg1DW3_JQ/artifacts/public/build/target.common.tests.zip 04:23:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RRzistD9SHSUBwg1DW3_JQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:23:17 INFO - Fetch https://queue.taskcluster.net/v1/task/RRzistD9SHSUBwg1DW3_JQ/artifacts/public/build/target.common.tests.zip into memory 04:23:23 INFO - Expected file size: 59715349 04:23:23 INFO - Obtained file size: 59715349 04:23:32 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:23:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RRzistD9SHSUBwg1DW3_JQ/artifacts/public/build/target.common.tests.zip 04:23:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RRzistD9SHSUBwg1DW3_JQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:23:32 INFO - Fetch https://queue.taskcluster.net/v1/task/RRzistD9SHSUBwg1DW3_JQ/artifacts/public/build/target.common.tests.zip into memory 04:23:34 INFO - Expected file size: 59715349 04:23:34 INFO - Obtained file size: 59715349 04:23:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RRzistD9SHSUBwg1DW3_JQ/artifacts/public/build/target.talos.tests.zip 04:23:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RRzistD9SHSUBwg1DW3_JQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:23:45 INFO - Fetch https://queue.taskcluster.net/v1/task/RRzistD9SHSUBwg1DW3_JQ/artifacts/public/build/target.talos.tests.zip into memory 04:23:46 INFO - Expected file size: 14404449 04:23:46 INFO - Obtained file size: 14404449 04:23:46 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')]} 04:23:46 INFO - trying https://queue.taskcluster.net/v1/task/RRzistD9SHSUBwg1DW3_JQ/artifacts/public/build/target.tar.bz2 04:23:46 INFO - Downloading https://queue.taskcluster.net/v1/task/RRzistD9SHSUBwg1DW3_JQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:23:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RRzistD9SHSUBwg1DW3_JQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:23:47 INFO - Downloaded 59748390 bytes. 04:23:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RRzistD9SHSUBwg1DW3_JQ/artifacts/public/build/target.tar.bz2 04:23:47 INFO - mkdir: /builds/slave/test/properties 04:23:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:23:47 INFO - Writing to file /builds/slave/test/properties/build_url 04:23:47 INFO - Contents: 04:23:47 INFO - build_url:https://queue.taskcluster.net/v1/task/RRzistD9SHSUBwg1DW3_JQ/artifacts/public/build/target.tar.bz2 04:23:47 INFO - Running post-action listener: _resource_record_post_action 04:23:47 INFO - Running post-action listener: set_extra_try_arguments 04:23:47 INFO - [mozharness: 2017-05-22 11:23:47.893138Z] Finished download-and-extract step (success) 04:23:47 INFO - [mozharness: 2017-05-22 11:23:47.893236Z] Running populate-webroot step. 04:23:47 INFO - Running pre-action listener: _resource_record_pre_action 04:23:47 INFO - Running main action method: populate_webroot 04:23:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:23:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:23:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:23:47 INFO - '--tppagecycles', 04:23:47 INFO - '7'], 04:23:47 INFO - 'tests': ['tsvgm']}}, 04:23:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:23:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:23:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:23:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:23:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:23:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:23:47 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:23:47 INFO - 'talos_options': ['--disable-e10s'], 04:23:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:23:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:23:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:23:47 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:23:47 INFO - 'talos_options': ['--disable-e10s'], 04:23:47 INFO - 'tests': ['damp', 'tps']}, 04:23:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:23:47 INFO - 'tests': ['damp', 'tps']}, 04:23:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:23:47 INFO - 'tests': ['dromaeo_dom']}, 04:23:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:23:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:23:47 INFO - 'tests': ['basic_compositor_video']}, 04:23:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:23:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:23:47 INFO - 'tests': ['a11yr', 04:23:47 INFO - 'ts_paint', 04:23:47 INFO - 'tpaint', 04:23:47 INFO - 'sessionrestore', 04:23:47 INFO - 'sessionrestore_no_auto_restore', 04:23:47 INFO - 'tabpaint']}, 04:23:47 INFO - 'other-e10s': {'tests': ['a11yr', 04:23:47 INFO - 'ts_paint', 04:23:47 INFO - 'tpaint', 04:23:47 INFO - 'sessionrestore', 04:23:47 INFO - 'sessionrestore_no_auto_restore', 04:23:47 INFO - 'tabpaint']}, 04:23:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:23:47 INFO - 'ts_paint', 04:23:47 INFO - 'tpaint', 04:23:47 INFO - 'sessionrestore', 04:23:47 INFO - 'sessionrestore_no_auto_restore', 04:23:47 INFO - 'tabpaint']}, 04:23:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:23:47 INFO - 'ts_paint', 04:23:47 INFO - 'tpaint', 04:23:47 INFO - 'sessionrestore', 04:23:47 INFO - 'sessionrestore_no_auto_restore', 04:23:47 INFO - 'tabpaint']}, 04:23:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:23:47 INFO - 'tests': ['a11yr', 04:23:47 INFO - 'ts_paint', 04:23:47 INFO - 'tpaint', 04:23:47 INFO - 'sessionrestore', 04:23:47 INFO - 'sessionrestore_no_auto_restore', 04:23:47 INFO - 'tabpaint']}, 04:23:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:23:47 INFO - 'tests': ['a11yr', 04:23:47 INFO - 'ts_paint', 04:23:47 INFO - 'tpaint', 04:23:47 INFO - 'sessionrestore', 04:23:47 INFO - 'sessionrestore_no_auto_restore', 04:23:47 INFO - 'tabpaint']}, 04:23:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:23:47 INFO - 'tests': ['tsvgx', 04:23:47 INFO - 'tsvgr_opacity', 04:23:47 INFO - 'tart', 04:23:47 INFO - 'tscrollx', 04:23:47 INFO - 'cart', 04:23:47 INFO - 'tsvg_static']}, 04:23:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:23:47 INFO - 'tsvgr_opacity', 04:23:47 INFO - 'tart', 04:23:47 INFO - 'tscrollx', 04:23:47 INFO - 'cart', 04:23:47 INFO - 'tsvg_static']}, 04:23:47 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:23:47 INFO - 'talos_options': ['--disable-e10s'], 04:23:47 INFO - 'tests': ['tp5o']}, 04:23:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:23:47 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:23:47 INFO - 'talos_options': ['--disable-e10s', 04:23:47 INFO - '--xperf_path', 04:23:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:23:47 INFO - 'tests': ['tp5n']}, 04:23:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:23:47 INFO - 'talos_options': ['--xperf_path', 04:23:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:23:47 INFO - 'tests': ['tp5n']}}, 04:23:47 INFO - 'talos.zip': {'path': '', 04:23:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:23:47 INFO - Running post-action listener: _resource_record_post_action 04:23:47 INFO - [mozharness: 2017-05-22 11:23:47.906409Z] Finished populate-webroot step (success) 04:23:47 INFO - [mozharness: 2017-05-22 11:23:47.906500Z] Running create-virtualenv step. 04:23:47 INFO - Running pre-action listener: _resource_record_pre_action 04:23:47 INFO - Running main action method: create_virtualenv 04:23:47 INFO - Creating virtualenv /builds/slave/test/build/venv 04:23:47 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 04:23:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:23:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:23:47 INFO - Using real prefix '/usr' 04:23:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:23:48 INFO - Installing distribute.............................................................................................................................................................................................done. 04:23:50 INFO - Installing pip.................done. 04:23:50 INFO - Return code: 0 04:23:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:23:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:23:50 INFO - Reading from file tmpfile_stdout 04:23:50 INFO - Output received: 04:23:50 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) 04:23:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:23:50 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')]} 04:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:50 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')]} 04:23:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:50 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 0xbaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbeda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4a400>, '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 0xe4b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4b840>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1495448663.425565-1728233154', '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 04:23:50 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 04:23:50 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 04:23:50 INFO - Using env: {'DISPLAY': ':0', 04:23:50 INFO - 'HOME': '/home/cltbld', 04:23:50 INFO - 'LANG': 'en_US.UTF-8', 04:23:50 INFO - 'LANGUAGE': 'en_US:en', 04:23:50 INFO - 'LOGNAME': 'cltbld', 04:23:50 INFO - 'MAIL': '/var/mail/cltbld', 04:23:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:50 INFO - 'MOZ_NO_REMOTE': '1', 04:23:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:50 INFO - 'NO_EM_RESTART': '1', 04:23:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:50 INFO - 'PWD': '/builds/slave/test', 04:23:50 INFO - 'SHELL': '/bin/bash', 04:23:50 INFO - 'SHLVL': '1', 04:23:50 INFO - 'TERM': 'linux', 04:23:50 INFO - 'TMOUT': '86400', 04:23:50 INFO - 'USER': 'cltbld', 04:23:50 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1495448663.425565-1728233154', 04:23:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:50 INFO - '_': '/tools/buildbot/bin/python'} 04:23:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:50 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 04:23:50 INFO - Cleaning up... 04:23:50 INFO - Return code: 0 04:23:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:23:50 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')]} 04:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:50 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')]} 04:23:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:51 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 0xbaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbeda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4a400>, '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 0xe4b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4b840>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1495448663.425565-1728233154', '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 04:23:51 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 04:23:51 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 04:23:51 INFO - Using env: {'DISPLAY': ':0', 04:23:51 INFO - 'HOME': '/home/cltbld', 04:23:51 INFO - 'LANG': 'en_US.UTF-8', 04:23:51 INFO - 'LANGUAGE': 'en_US:en', 04:23:51 INFO - 'LOGNAME': 'cltbld', 04:23:51 INFO - 'MAIL': '/var/mail/cltbld', 04:23:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:51 INFO - 'MOZ_NO_REMOTE': '1', 04:23:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:51 INFO - 'NO_EM_RESTART': '1', 04:23:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:51 INFO - 'PWD': '/builds/slave/test', 04:23:51 INFO - 'SHELL': '/bin/bash', 04:23:51 INFO - 'SHLVL': '1', 04:23:51 INFO - 'TERM': 'linux', 04:23:51 INFO - 'TMOUT': '86400', 04:23:51 INFO - 'USER': 'cltbld', 04:23:51 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1495448663.425565-1728233154', 04:23:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:51 INFO - '_': '/tools/buildbot/bin/python'} 04:23:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:51 INFO - Downloading/unpacking psutil>=3.1.1 04:23:51 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 04:23:51 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 04:23:51 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 04:23:51 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 04:23:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:23:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:23:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:23:52 INFO - Installing collected packages: psutil 04:23:52 INFO - Running setup.py install for psutil 04:23:52 INFO - building 'psutil._psutil_linux' extension 04:23:52 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 04:23:52 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 04:23:52 INFO - building 'psutil._psutil_posix' extension 04:23:52 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 04:23:52 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 04:23:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:23:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:23:52 INFO - Successfully installed psutil 04:23:52 INFO - Cleaning up... 04:23:52 INFO - Return code: 0 04:23:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:23:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:53 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 0xbaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbeda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4a400>, '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 0xe4b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4b840>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1495448663.425565-1728233154', '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 04:23:53 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 04:23:53 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 04:23:53 INFO - Using env: {'DISPLAY': ':0', 04:23:53 INFO - 'HOME': '/home/cltbld', 04:23:53 INFO - 'LANG': 'en_US.UTF-8', 04:23:53 INFO - 'LANGUAGE': 'en_US:en', 04:23:53 INFO - 'LOGNAME': 'cltbld', 04:23:53 INFO - 'MAIL': '/var/mail/cltbld', 04:23:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:53 INFO - 'MOZ_NO_REMOTE': '1', 04:23:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:53 INFO - 'NO_EM_RESTART': '1', 04:23:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:53 INFO - 'PWD': '/builds/slave/test', 04:23:53 INFO - 'SHELL': '/bin/bash', 04:23:53 INFO - 'SHLVL': '1', 04:23:53 INFO - 'TERM': 'linux', 04:23:53 INFO - 'TMOUT': '86400', 04:23:53 INFO - 'USER': 'cltbld', 04:23:53 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1495448663.425565-1728233154', 04:23:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:53 INFO - '_': '/tools/buildbot/bin/python'} 04:23:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:23:53 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 04:23:53 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 04:23:53 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 04:23:53 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 04:23:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:23:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:23:54 INFO - Installing collected packages: mozsystemmonitor 04:23:54 INFO - Running setup.py install for mozsystemmonitor 04:23:55 INFO - Successfully installed mozsystemmonitor 04:23:55 INFO - Cleaning up... 04:23:55 INFO - Return code: 0 04:23:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:23: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')]} 04:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23: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')]} 04:23:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:55 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 0xbaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbeda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4a400>, '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 0xe4b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4b840>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1495448663.425565-1728233154', '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 04:23:55 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 04:23:55 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 04:23:55 INFO - Using env: {'DISPLAY': ':0', 04:23:55 INFO - 'HOME': '/home/cltbld', 04:23:55 INFO - 'LANG': 'en_US.UTF-8', 04:23:55 INFO - 'LANGUAGE': 'en_US:en', 04:23:55 INFO - 'LOGNAME': 'cltbld', 04:23:55 INFO - 'MAIL': '/var/mail/cltbld', 04:23:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:55 INFO - 'MOZ_NO_REMOTE': '1', 04:23:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:55 INFO - 'NO_EM_RESTART': '1', 04:23:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:55 INFO - 'PWD': '/builds/slave/test', 04:23:55 INFO - 'SHELL': '/bin/bash', 04:23:55 INFO - 'SHLVL': '1', 04:23:55 INFO - 'TERM': 'linux', 04:23:55 INFO - 'TMOUT': '86400', 04:23:55 INFO - 'USER': 'cltbld', 04:23:55 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1495448663.425565-1728233154', 04:23:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:55 INFO - '_': '/tools/buildbot/bin/python'} 04:23:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:55 INFO - Downloading/unpacking jsonschema==2.5.1 04:23:55 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 04:23:55 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 04:23:55 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 04:23:55 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 04:23:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:23:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:23:57 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 04:23:57 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 04:23:57 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 04:23:57 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 04:23:57 INFO - Downloading functools32-3.2.3-2.tar.gz 04:23:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:23:57 INFO - warning: no files found matching '*.txt' 04:23:57 INFO - no previously-included directories found matching 'build' 04:23:57 INFO - no previously-included directories found matching 'dist' 04:23:57 INFO - no previously-included directories found matching '.git*' 04:23:57 INFO - Installing collected packages: jsonschema, functools32 04:23:57 INFO - Running setup.py install for functools32 04:23:57 INFO - warning: no files found matching '*.txt' 04:23:57 INFO - no previously-included directories found matching 'build' 04:23:57 INFO - no previously-included directories found matching 'dist' 04:23:57 INFO - no previously-included directories found matching '.git*' 04:23:57 INFO - Successfully installed jsonschema functools32 04:23:57 INFO - Cleaning up... 04:23:57 INFO - Return code: 0 04:23:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:23:57 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')]} 04:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:57 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')]} 04:23:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:57 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 0xbaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbeda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4a400>, '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 0xe4b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4b840>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1495448663.425565-1728233154', '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 04:23:57 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 04:23:57 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 04:23:57 INFO - Using env: {'DISPLAY': ':0', 04:23:57 INFO - 'HOME': '/home/cltbld', 04:23:57 INFO - 'LANG': 'en_US.UTF-8', 04:23:57 INFO - 'LANGUAGE': 'en_US:en', 04:23:57 INFO - 'LOGNAME': 'cltbld', 04:23:57 INFO - 'MAIL': '/var/mail/cltbld', 04:23:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:57 INFO - 'MOZ_NO_REMOTE': '1', 04:23:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:57 INFO - 'NO_EM_RESTART': '1', 04:23:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:57 INFO - 'PWD': '/builds/slave/test', 04:23:57 INFO - 'SHELL': '/bin/bash', 04:23:57 INFO - 'SHLVL': '1', 04:23:57 INFO - 'TERM': 'linux', 04:23:57 INFO - 'TMOUT': '86400', 04:23:57 INFO - 'USER': 'cltbld', 04:23:57 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1495448663.425565-1728233154', 04:23:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:57 INFO - '_': '/tools/buildbot/bin/python'} 04:23:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:23:57 INFO - Cleaning up... 04:23:57 INFO - Return code: 0 04:23:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:23:57 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')]} 04:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:57 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')]} 04:23:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:57 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 0xbaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbeda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4a400>, '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 0xe4b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4b840>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1495448663.425565-1728233154', '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 04:23:57 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 04:23:57 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 04:23:57 INFO - Using env: {'DISPLAY': ':0', 04:23:57 INFO - 'HOME': '/home/cltbld', 04:23:57 INFO - 'LANG': 'en_US.UTF-8', 04:23:57 INFO - 'LANGUAGE': 'en_US:en', 04:23:57 INFO - 'LOGNAME': 'cltbld', 04:23:57 INFO - 'MAIL': '/var/mail/cltbld', 04:23:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:57 INFO - 'MOZ_NO_REMOTE': '1', 04:23:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:57 INFO - 'NO_EM_RESTART': '1', 04:23:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:57 INFO - 'PWD': '/builds/slave/test', 04:23:57 INFO - 'SHELL': '/bin/bash', 04:23:57 INFO - 'SHLVL': '1', 04:23:57 INFO - 'TERM': 'linux', 04:23:57 INFO - 'TMOUT': '86400', 04:23:57 INFO - 'USER': 'cltbld', 04:23:57 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1495448663.425565-1728233154', 04:23:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:57 INFO - '_': '/tools/buildbot/bin/python'} 04:23:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:58 INFO - Downloading/unpacking blobuploader==1.2.4 04:23:58 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 04:23:58 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 04:23:58 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 04:23:58 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 04:23:59 INFO - Downloading blobuploader-1.2.4.tar.gz 04:23:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:23:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:23:59 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 04:23:59 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 04:23:59 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 04:23:59 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 04:23:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:23:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:23:59 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 04:23:59 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 04:23:59 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 04:23:59 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 04:23:59 INFO - Downloading docopt-0.6.1.tar.gz 04:23:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:23:59 INFO - Installing collected packages: blobuploader, requests, docopt 04:23:59 INFO - Running setup.py install for blobuploader 04:23:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:23:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:23:59 INFO - Running setup.py install for requests 04:24:00 INFO - Running setup.py install for docopt 04:24:00 INFO - Successfully installed blobuploader requests docopt 04:24:00 INFO - Cleaning up... 04:24:00 INFO - Return code: 0 04:24:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:24: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')]} 04:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24: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')]} 04:24:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:00 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 0xbaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbeda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4a400>, '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 0xe4b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4b840>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1495448663.425565-1728233154', '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 04:24:00 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 04:24:00 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 04:24:00 INFO - Using env: {'DISPLAY': ':0', 04:24:00 INFO - 'HOME': '/home/cltbld', 04:24:00 INFO - 'LANG': 'en_US.UTF-8', 04:24:00 INFO - 'LANGUAGE': 'en_US:en', 04:24:00 INFO - 'LOGNAME': 'cltbld', 04:24:00 INFO - 'MAIL': '/var/mail/cltbld', 04:24:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:00 INFO - 'MOZ_NO_REMOTE': '1', 04:24:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:00 INFO - 'NO_EM_RESTART': '1', 04:24:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:00 INFO - 'PWD': '/builds/slave/test', 04:24:00 INFO - 'SHELL': '/bin/bash', 04:24:00 INFO - 'SHLVL': '1', 04:24:00 INFO - 'TERM': 'linux', 04:24:00 INFO - 'TMOUT': '86400', 04:24:00 INFO - 'USER': 'cltbld', 04:24:00 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1495448663.425565-1728233154', 04:24:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:00 INFO - '_': '/tools/buildbot/bin/python'} 04:24:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:24:00 INFO - Running setup.py (path:/tmp/pip-5lG_la-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:24:00 INFO - Running setup.py (path:/tmp/pip-AeB91u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:24:00 INFO - Running setup.py (path:/tmp/pip-hwm5yz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:24:00 INFO - Running setup.py (path:/tmp/pip-DLor_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:24:00 INFO - Running setup.py (path:/tmp/pip-c1pFd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:24:00 INFO - Running setup.py (path:/tmp/pip-BRSTsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:24:00 INFO - Running setup.py (path:/tmp/pip-1iy2eq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:24:01 INFO - Running setup.py (path:/tmp/pip-t5EcAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:24:01 INFO - Running setup.py (path:/tmp/pip-_XCJXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:24:01 INFO - Running setup.py (path:/tmp/pip-0e_lNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:24:01 INFO - Running setup.py (path:/tmp/pip-DldWcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:24:01 INFO - Running setup.py (path:/tmp/pip-sLAFtr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:24:01 INFO - Running setup.py (path:/tmp/pip-OA1cux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:24:01 INFO - Running setup.py (path:/tmp/pip-C3Eiv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:01 INFO - Running setup.py (path:/tmp/pip-OvwdN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:24:01 INFO - Running setup.py (path:/tmp/pip-_Ues_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:24:01 INFO - Running setup.py (path:/tmp/pip-wuKDub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:24:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:24:01 INFO - Running setup.py install for manifestparser 04:24:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:24:01 INFO - Running setup.py install for mozcrash 04:24:01 INFO - Running setup.py install for mozdebug 04:24:02 INFO - Running setup.py install for mozdevice 04:24:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:24:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:24:02 INFO - Running setup.py install for mozfile 04:24:02 INFO - Running setup.py install for mozhttpd 04:24:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:24:02 INFO - Running setup.py install for mozinfo 04:24:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:24:02 INFO - Running setup.py install for mozInstall 04:24:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:24:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:24:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:24:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:24:02 INFO - Running setup.py install for mozleak 04:24:02 INFO - Running setup.py install for mozlog 04:24:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:24:02 INFO - Running setup.py install for moznetwork 04:24:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:24:02 INFO - Running setup.py install for mozprocess 04:24:03 INFO - Running setup.py install for mozprofile 04:24:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:24:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:24:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:24:03 INFO - Running setup.py install for mozrunner 04:24:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:24:03 INFO - Running setup.py install for mozscreenshot 04:24:03 INFO - Running setup.py install for moztest 04:24:03 INFO - Running setup.py install for mozversion 04:24:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:24:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:24:03 INFO - Cleaning up... 04:24:03 INFO - Return code: 0 04:24:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:24:03 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')]} 04:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:03 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')]} 04:24:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:03 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 0xbaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbeda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4a400>, '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 0xe4b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4b840>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1495448663.425565-1728233154', '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 04:24:03 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 04:24:03 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 04:24:03 INFO - Using env: {'DISPLAY': ':0', 04:24:03 INFO - 'HOME': '/home/cltbld', 04:24:03 INFO - 'LANG': 'en_US.UTF-8', 04:24:03 INFO - 'LANGUAGE': 'en_US:en', 04:24:03 INFO - 'LOGNAME': 'cltbld', 04:24:03 INFO - 'MAIL': '/var/mail/cltbld', 04:24:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:03 INFO - 'MOZ_NO_REMOTE': '1', 04:24:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:03 INFO - 'NO_EM_RESTART': '1', 04:24:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:03 INFO - 'PWD': '/builds/slave/test', 04:24:03 INFO - 'SHELL': '/bin/bash', 04:24:03 INFO - 'SHLVL': '1', 04:24:03 INFO - 'TERM': 'linux', 04:24:03 INFO - 'TMOUT': '86400', 04:24:03 INFO - 'USER': 'cltbld', 04:24:03 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1495448663.425565-1728233154', 04:24:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:03 INFO - '_': '/tools/buildbot/bin/python'} 04:24:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:24:03 INFO - Running setup.py (path:/tmp/pip-rS5JOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:24:03 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)) 04:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:24:03 INFO - Running setup.py (path:/tmp/pip-hNwGwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:24:03 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)) 04:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:24:03 INFO - Running setup.py (path:/tmp/pip-tXbZmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:24:04 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)) 04:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:24:04 INFO - Running setup.py (path:/tmp/pip-RduiXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:24:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 04:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:24:04 INFO - Running setup.py (path:/tmp/pip-Pj3ylB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:24:04 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)) 04:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:24:04 INFO - Running setup.py (path:/tmp/pip-Ve3ryZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:24:04 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)) 04:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:24:04 INFO - Running setup.py (path:/tmp/pip-FtxNFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:24:04 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)) 04:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:24:04 INFO - Running setup.py (path:/tmp/pip-1Nw5dq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:24:04 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)) 04:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:24:04 INFO - Running setup.py (path:/tmp/pip-lowMze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:24:04 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)) 04:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:24:04 INFO - Running setup.py (path:/tmp/pip-bpv9o3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:24:04 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)) 04:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:24:04 INFO - Running setup.py (path:/tmp/pip-veYEEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:24:04 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)) 04:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:24:04 INFO - Running setup.py (path:/tmp/pip-Q5bSW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:24:04 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)) 04:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:24:04 INFO - Running setup.py (path:/tmp/pip-FQ42Fu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:24:04 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)) 04:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:24:04 INFO - Running setup.py (path:/tmp/pip-baodxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:24:04 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)) 04:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:04 INFO - Running setup.py (path:/tmp/pip-eP81Q9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:04 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)) 04:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:24:04 INFO - Running setup.py (path:/tmp/pip-lNOZye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:24:04 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)) 04:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:24:04 INFO - Running setup.py (path:/tmp/pip-8ZZcy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:24:05 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)) 04:24:05 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)) 04:24:05 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)) 04:24:05 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)) 04:24:05 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:24:05 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:24:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:24:05 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 04:24:05 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 04:24:05 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 04:24:05 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 04:24:06 INFO - Downloading blessings-1.6.tar.gz 04:24:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:24:06 INFO - Installing collected packages: blessings 04:24:06 INFO - Running setup.py install for blessings 04:24:06 INFO - Successfully installed blessings 04:24:06 INFO - Cleaning up... 04:24:06 INFO - Return code: 0 04:24:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:24:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:24:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:24:06 INFO - Reading from file tmpfile_stdout 04:24:06 INFO - Current package versions: 04:24:06 INFO - argparse == 1.2.1 04:24:06 INFO - blessings == 1.6 04:24:06 INFO - blobuploader == 1.2.4 04:24:06 INFO - docopt == 0.6.1 04:24:06 INFO - functools32 == 3.2.3-2 04:24:06 INFO - jsonschema == 2.5.1 04:24:06 INFO - manifestparser == 1.1 04:24:06 INFO - mozInstall == 1.12 04:24:06 INFO - mozcrash == 1.0 04:24:06 INFO - mozdebug == 0.1 04:24:06 INFO - mozdevice == 0.49 04:24:06 INFO - mozfile == 1.2 04:24:06 INFO - mozhttpd == 0.7 04:24:06 INFO - mozinfo == 0.9 04:24:06 INFO - mozleak == 0.1 04:24:06 INFO - mozlog == 3.4 04:24:06 INFO - moznetwork == 0.27 04:24:06 INFO - mozprocess == 0.25 04:24:06 INFO - mozprofile == 0.28 04:24:06 INFO - mozrunner == 6.13 04:24:06 INFO - mozscreenshot == 0.1 04:24:06 INFO - mozsystemmonitor == 0.3 04:24:06 INFO - moztest == 0.8 04:24:06 INFO - mozversion == 1.4 04:24:06 INFO - psutil == 3.1.1 04:24:06 INFO - requests == 1.2.3 04:24:06 INFO - wsgiref == 0.1.2 04:24:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:06 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 0xbaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbeda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4a400>, '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 0xe4b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4b840>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1495448663.425565-1728233154', '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 04:24:06 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 04:24:06 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 04:24:06 INFO - Using env: {'DISPLAY': ':0', 04:24:06 INFO - 'HOME': '/home/cltbld', 04:24:06 INFO - 'LANG': 'en_US.UTF-8', 04:24:06 INFO - 'LANGUAGE': 'en_US:en', 04:24:06 INFO - 'LOGNAME': 'cltbld', 04:24:06 INFO - 'MAIL': '/var/mail/cltbld', 04:24:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:06 INFO - 'MOZ_NO_REMOTE': '1', 04:24:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:06 INFO - 'NO_EM_RESTART': '1', 04:24:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:06 INFO - 'PWD': '/builds/slave/test', 04:24:06 INFO - 'SHELL': '/bin/bash', 04:24:06 INFO - 'SHLVL': '1', 04:24:06 INFO - 'TERM': 'linux', 04:24:06 INFO - 'TMOUT': '86400', 04:24:06 INFO - 'USER': 'cltbld', 04:24:06 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1495448663.425565-1728233154', 04:24:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:06 INFO - '_': '/tools/buildbot/bin/python'} 04:24:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:06 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)) 04:24:06 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)) 04:24:06 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)) 04:24:06 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)) 04:24:06 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)) 04:24:06 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)) 04:24:06 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)) 04:24:06 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)) 04:24:06 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)) 04:24:06 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)) 04:24:06 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)) 04:24:06 INFO - Cleaning up... 04:24:06 INFO - Return code: 0 04:24:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbeda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4a400>, '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 0xe4b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4b840>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1495448663.425565-1728233154', '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 04:24:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:24:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:24:06 INFO - Using env: {'DISPLAY': ':0', 04:24:06 INFO - 'HOME': '/home/cltbld', 04:24:06 INFO - 'LANG': 'en_US.UTF-8', 04:24:06 INFO - 'LANGUAGE': 'en_US:en', 04:24:06 INFO - 'LOGNAME': 'cltbld', 04:24:06 INFO - 'MAIL': '/var/mail/cltbld', 04:24:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:06 INFO - 'MOZ_NO_REMOTE': '1', 04:24:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:06 INFO - 'NO_EM_RESTART': '1', 04:24:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:06 INFO - 'PWD': '/builds/slave/test', 04:24:06 INFO - 'SHELL': '/bin/bash', 04:24:06 INFO - 'SHLVL': '1', 04:24:06 INFO - 'TERM': 'linux', 04:24:06 INFO - 'TMOUT': '86400', 04:24:06 INFO - 'USER': 'cltbld', 04:24:06 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1495448663.425565-1728233154', 04:24:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:06 INFO - '_': '/tools/buildbot/bin/python'} 04:24:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:24:07 INFO - Cleaning up... 04:24:07 INFO - Return code: 0 04:24:07 INFO - Running post-action listener: _resource_record_post_action 04:24:07 INFO - Running post-action listener: _start_resource_monitoring 04:24:07 INFO - Starting resource monitoring. 04:24:07 INFO - [mozharness: 2017-05-22 11:24:07.140894Z] Finished create-virtualenv step (success) 04:24:07 INFO - [mozharness: 2017-05-22 11:24:07.141359Z] Running install step. 04:24:07 INFO - Running pre-action listener: _resource_record_pre_action 04:24:07 INFO - Running main action method: install 04:24:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:24:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:24:07 INFO - Reading from file tmpfile_stdout 04:24:07 INFO - Detecting whether we're running mozinstall >=1.0... 04:24:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:24:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:24:07 INFO - Reading from file tmpfile_stdout 04:24:07 INFO - Output received: 04:24:07 INFO - Usage: mozinstall [options] installer 04:24:07 INFO - Options: 04:24:07 INFO - -h, --help show this help message and exit 04:24:07 INFO - -d DEST, --destination=DEST 04:24:07 INFO - Directory to install application into. [default: 04:24:07 INFO - "/builds/slave/test"] 04:24:07 INFO - --app=APP Application being installed. [default: firefox] 04:24:07 INFO - mkdir: /builds/slave/test/build/application 04:24:07 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'] 04:24:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:24:21 INFO - Reading from file tmpfile_stdout 04:24:21 INFO - Output received: 04:24:21 INFO - /builds/slave/test/build/application/firefox/firefox 04:24:21 INFO - Running post-action listener: _resource_record_post_action 04:24:21 INFO - [mozharness: 2017-05-22 11:24:21.547546Z] Finished install step (success) 04:24:21 INFO - [mozharness: 2017-05-22 11:24:21.547853Z] Running run-tests step. 04:24:21 INFO - Running pre-action listener: _resource_record_pre_action 04:24:21 INFO - Running main action method: run_tests 04:24:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:24:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:24:21 INFO - Python 2.7.3 04:24:21 INFO - Return code: 0 04:24:21 INFO - grabbing minidump binary from tooltool 04:24:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:21 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 0xe4a400>, '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 0xe4b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4b840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:24:21 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 04:24:21 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 04:24:21 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 04:24:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:24:21 INFO - Return code: 0 04:24:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:24:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:24:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:24:21 INFO - ENV: RUST_BACKTRACE is now 1 04:24:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:24:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:24:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RRzistD9SHSUBwg1DW3_JQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:24:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RRzistD9SHSUBwg1DW3_JQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:24:21 INFO - Using env: {'DISPLAY': ':0', 04:24:21 INFO - 'HOME': '/home/cltbld', 04:24:21 INFO - 'LANG': 'en_US.UTF-8', 04:24:21 INFO - 'LANGUAGE': 'en_US:en', 04:24:21 INFO - 'LOGNAME': 'cltbld', 04:24:21 INFO - 'MAIL': '/var/mail/cltbld', 04:24:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:24:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:24:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:21 INFO - 'MOZ_NO_REMOTE': '1', 04:24:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:24:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:21 INFO - 'NO_EM_RESTART': '1', 04:24:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:21 INFO - 'PWD': '/builds/slave/test', 04:24:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:24:21 INFO - 'RUST_BACKTRACE': '1', 04:24:21 INFO - 'SHELL': '/bin/bash', 04:24:21 INFO - 'SHLVL': '1', 04:24:21 INFO - 'TERM': 'linux', 04:24:21 INFO - 'TMOUT': '86400', 04:24:21 INFO - 'USER': 'cltbld', 04:24:21 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1495448663.425565-1728233154', 04:24:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:21 INFO - '_': '/tools/buildbot/bin/python'} 04:24:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RRzistD9SHSUBwg1DW3_JQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:24:21 INFO - mozversion application_buildid: 20170522103107 04:24:21 INFO - mozversion application_changeset: 053736317dff63597082150329642427c76ddc16 04:24:21 INFO - mozversion application_display_name: Firefox 04:24:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:24:21 INFO - mozversion application_name: Firefox 04:24:21 INFO - mozversion application_remotingname: firefox 04:24:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:24:21 INFO - mozversion application_vendor: Mozilla 04:24:21 INFO - mozversion application_version: 54.0 04:24:21 INFO - mozversion platform_buildid: 20170522103107 04:24:21 INFO - mozversion platform_changeset: 053736317dff63597082150329642427c76ddc16 04:24:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:24:21 INFO - mozversion platform_version: 54.0 04:24:21 INFO - using testdate: 1495452261 04:24:21 INFO - actual date: 1495452261 04:24:21 INFO - starting webserver on 'localhost:49279' 04:24:21 INFO - SUITE-START | Running 2 tests 04:24:21 INFO - TEST-START | dromaeo_css 04:24:21 INFO - operating with platform_type : linux_ 04:24:21 INFO - Initialising browser for dromaeo_css test... 04:24:21 INFO - TEST-INFO | started process 7920 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1Bnq02/profile http://localhost:49279/getInfo.html) 04:24:26 INFO - PROCESS | 7920 | __metrics Screen width/height:1600/1200 04:24:26 INFO - PROCESS | 7920 | colorDepth:24 04:24:26 INFO - PROCESS | 7920 | Browser inner width/height: 1024/697 04:24:26 INFO - PROCESS | 7920 | __metrics 04:24:27 INFO - PROCESS | 7920 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:24:27 INFO - PROCESS | 7920 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:24:28 INFO - TEST-INFO | 7920: exit 0 04:24:28 INFO - Browser initialized. 04:24:28 INFO - Running cycle 1/1 for dromaeo_css test... 04:24:28 INFO - TEST-INFO | started process 8012 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1Bnq02/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:24:40 INFO - PROCESS | 8012 | RSS: Main: 141623296 04:24:40 INFO - PROCESS | 8012 | 04:27:42 INFO - PROCESS | 8012 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 04:27:43 INFO - PROCESS | 8012 | RSS: Main: 280289280 04:27:43 INFO - PROCESS | 8012 | 04:30:45 INFO - PROCESS | 8012 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 04:30:46 INFO - PROCESS | 8012 | RSS: Main: 219901952 04:30:46 INFO - PROCESS | 8012 | 04:33:48 INFO - PROCESS | 8012 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 04:33:49 INFO - PROCESS | 8012 | RSS: Main: 171077632 04:33:49 INFO - PROCESS | 8012 | 04:36:50 INFO - PROCESS | 8012 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 04:36:51 INFO - PROCESS | 8012 | RSS: Main: 171745280 04:36:51 INFO - PROCESS | 8012 | 04:39:54 INFO - PROCESS | 8012 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 04:39:54 INFO - PROCESS | 8012 | RSS: Main: 175120384 04:39:54 INFO - PROCESS | 8012 | 04:42:57 INFO - PROCESS | 8012 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 04:42:57 INFO - PROCESS | 8012 | RSS: Main: 262135808 04:42:57 INFO - PROCESS | 8012 | 04:42:57 INFO - PROCESS | 8012 | __start_tp_report 04:42:57 INFO - PROCESS | 8012 | _x_x_mozilla_page_load 04:42:57 INFO - PROCESS | 8012 | _x_x_mozilla_page_load_details 04:42:57 INFO - PROCESS | 8012 | |i|pagename|runs| 04:42:57 INFO - PROCESS | 8012 | |0;dojo.html;3360.747943904207;3382.6786455286756;3396.049106250249;3423.8116903570294;3441.27733176033;5690.430956904307;5720.599558030939;5758.510526605233;5785.2189954356145;5786.161006654038;5704.429557044294;5785.421457854212;5801.680907550093;5805.158252053449;5814.040683287252;5275.36695596528;5291.814786482474;5326.6537675051195;5331.040412725727;5375.3280839895015;5074.492550744914;5115.13042782726;5343.572514198874;5369.9463005370035;5371.462853714617;5235.083860324447;5253.684778913258;5263.34208223972;5280.313559237294;5290.470952904717;5347.46525347466;5358.955003774266;5358.97320513395;5360.142377219665;5361.571074314045;5061.16490779021;5204.063268611649;5251.947480525184;5328.040952628526;5333.493318134771;5594.524465420444;5595.720213989325;5700.914486282709;5704.857378565569;5712.8000519982015;6147;6166.445019948226;6174.475169610589;6176.938230617681;6182.752689892399;6182.16116137596;6182.69086545671;6215.937840621581;6219.68901554925;6230.345813689542;5566.777328906839;5592.049351610236;5730.34101078373;5754.827355179351;5773.769049237983;6246.312905580383;6251.374862513712;6254.15568898202;6255.374462553799;6256.906146407808;5990.371011043865;6010.519158467312;6044.123602077674;6045.916716850294;6061.515078793686;5896.380880007623;5947.405259474018;6062.090686396988;6096.69516524172;6110.658101469769;6108.32831767288;6109.543923541144;6117.857853872152;6118.293648225464;6125.509959203342;5869.383714709894;5907.940920590825;5908.822735317947;6033.215681961317;6141.385861413823;4661.95338046622;4668.416447944007;4708.8116475341285;4717.787699553528;4729.952700472952;4078.5513593504693;4078.898027549335;4104.158647477319;4179.456670632859;4190.413342132104;5924.20023296858;5932.911006334908;5940.31686356066;5953.732082056318;5983.461488466059;6134.263888333428;6149.446549810538;6184.288806787187;6187.133801267826;6187.16473276102;5721.141828725725;5925.081612350093;5936.198613187251;5940.257467816523;5943.64338139713;5146.794128234828;5164.870878227999;5205.297284866495;5251.159814429673;5254.553362964114;6355.999999999907;6371.6814159290925;6391.872162556723;6407.231132264065;6408;6172.074188871705;6203.16257305258;6211.65835879031;6214.5028397728975;6230.408111229426;6133.946794548555;6174.44430001302;6202.72087756043;6203.379662033941;6254.562180647311;6000.909986350295;6025.457708806229;6028.6985650716415;6033.728482218223;6056.485198757979;6123.387661234019;6134.969325153345;6136.846578835565;6137.508999279958;6145.9692701536205;5754.741036653444;5813.796517122049;5933.821985340447;5944.940550594439;5969.104634304889;6012.6392416455155;6023.728932198149;6024.427679370453;6048.879022419439;6064.605800622945;5942;5989.251343582052;5996.760129594942;5999.70001499932;6004.909926351021;5731.426857314235;5762.164486149569;5792.4497172768515;5800.6809625471005;5804.187413762161;5832.096025116114;5876.853078673067;5876.941230587639;5879.118132280192;5883.646981181143 04:42:57 INFO - PROCESS | 8012 | |1;ext.html;759.589821496392;824.8556502612042;843.8312337532493;898.6719847255754;911.5487833522408;31285;44354.778226108865;45214.77392613032;45238.773806130965;45306;42844.785776071156;43077.35383969243;43151.56848431515;46978;47003.29495057577;7847.882281765778;9022.188003079722;9029.503377314246;9159.45043297401;9167.679131230409;7804.804879877992;10583;10702.197335199891;10805.945970270137;10813;10882.075023623001;10921.344719316867;10937.726556836064;10953.890461095367;10955.287906286107;10871.619493317696;10892.891071089267;10895.782084358349;10898.291611045297;10909.1818113641;10703.1437485001;10714;10765.03114719671;10793.028627423491;10808.837867431996;42378.78810605958;42390.57609423897;42668.78665606683;42677.57322426767;42772.14455710868;4277.123189746095;4339.132173565268;4360.454943132108;4498.122866041123;4525.027119169395;30151.246218844484;30157.547636785464;30290.84854575735;30876.691233087608;32398;4425.579569940851;4444.666650001231;4495.123450927071;4509.714731301596;4522.457305123374;225378;226019;226360;226541;226956.99999999834;53244.201336979975;53821.46178538243;53857.1921421179;53876.191857122176;53914.46085539173;55264.44735552673;55601;55659.72170139123;55686.44313556894;55812.441875581535;13854.515091971733;13972.72054558903;13987.440502379792;14004.159750415009;14005.789913151311;11612;11841.467133978991;13638.727225455435;13651.249181294925;13674.111182773087;13042.347882605833;13296.73406531864;13446.731065378637;13567.59297221085;13895.444182232597;5531.723413829292;5626.887462250732;5640.097584386478;5661.603687741818;5694.373618901917;996.656153627012;1002.9147522460672;1006.1296978114025;1014.5688082564881;1024.6311327921942;29140.708592914223;29184.124476265744;29464.852675736485;29493.557596636067;29495.410091798043;1074.8656417947757;1078.703356576932;1090.596479302663;1093.9617113400993;1097.2154909239932;14563;15414;15524.223788810741;15541.300641471162;15657;286545;287125;287564;287628;287869;56519;56616;56628.15057774137;56631.71684141635;56650.150247746315;1490.9478168264275;1530.3801960206135;1531.272645493404;1532;1536.170467947296;27843.58234626442;28395.290117746394;28606.71393286124;28770;29080.56379154272;36724.81637591795;36886.815565922;37042;37098.258034839695;37168.25663486769;275359;277015;278044;278518;278662;25672.614910776727;25977;29439.11682649524;30265.697343026288;31041.68958310388;36840;37154;37265.6273437273;39855;40437.39343909785;31432.37135257328;31548.52677209798;31661.208469787518;31703.365932681678;31765.20586985344;31038.68961310358;31382.52926206063;31572;31702.682973169973;31833.36333273275;35334.46998295079;35462.46806297856;35474;35674;36333.0916727084;29334.26664333409;29574.556381653863;29735.107946761633;29850;30133.698663013965;23592.88203558971;24946.0021599134;25138.874305628357;25443.236702898943;25495.36261593475 04:42:57 INFO - PROCESS | 8012 | |2;jquery.html;428.2890401932792;445.1630933844372;445.24086432632345;456.63469224620303;467.2174108368483;19984.90007549962;21583.352499425044;22018.4495387615;22145.33563993079;22261.888690556545;21861.890690546526;22370.66444003341;22804.54390912185;22929.42676433086;22965.19621813237;6660.333966603337;6878.380945714885;6934.479914006444;7295.416366690679;7609.467337286392;7221.025161603196;7561.697532098709;7594.658240379196;7606.695732170707;7608.353289970331;7627.122880868688;7660.4254680898875;7661.961690191569;7662.846743065135;7665.693372265103;7457.216992215821;7485.989391432141;7542.43431742616;7577.318041376275;7578.280063393969;7234.457415693844;7374.778756637309;7377.151627562792;7511.6995320187125;7588.468807183499;23362.010594654905;23512.177073802333;25967.480650386886;26617.33456663599;26895.86552067247;3033.514637657964;3146.5594816725675;3151.038933125396;3224.5002024685978;3225.467797813358;15707.371705131782;16661;16695.74956375655;16888;17263.309467621406;1959.6276707425543;2007.7791442941266;2011.2960463837685;2012.7081573171954;2053.3326668832688;116374;116390.41804790922;116916;119016;120799.99999999913;17905.20947905199;18104.547386315186;18294.54263643393;18453.261869525068;18598.721019184723;31804.363912722078;31822;31842.522362164586;32171;32230.83884580609;10264.332818366782;10320.587176512856;10380.32527885685;10495.737606559896;10562.947185264025;8707.6516939323;8734.86897696535;8817.382783205114;9057;9071.27429805614;9016.23362014223;9313.627454901864;9313.906860931304;9427.387219830689;9507.66723164686;3823.4073718573663;3863;3954.6440820326306;3975.64666689974;4049;944.1927152284835;949.378157306965;963.1620490173453;963.4604621412032;994.627014869424;20860.37418877436;21667.24164654261;21731.456713582287;21750.782492174876;21771.23800666969;960.0846311608386;961.5480724059681;966.6616684160488;968.5447839515416;981.8527220916777;11477.713057173638;11608.187426880206;11792.823107653392;11822.763544729058;11919.940400297943;641925;651322;655584;656416;674026;80420;95603;120802;122985.38507307586;128287;1410.5627255550812;1438.3239877257672;1468.148473885144;1471.3820195517908;1481.3037872200048;19005.239790408228;19326;19377.128029239;19511.317103901296;19601.803981959998;50695.74652126716;51219.48780512296;53072.73463632657;53567.4643253578;54428.72785636046;71706.61749641392;72855.27144728485;73458;73932.63033684797;74385;12334.568290109803;12404.75190496167;12578.55975040869;12580.496780128693;12596.622101336974;14176;14299.285035748379;14321.713565728836;14447.927760361132;14567.344469498687;12474;12768;12784;12948.417321220757;13116.278604676834;9756.365836220622;11630.476628551567;11712.472938717608;11886.108541859569;12072.154949153475;12251.448684809384;12376.690582735144;12395.75208495843;12680.302583358003;12800.935995320337;12023.398830058637;12148.635540933787;12304.200226985216;12455;12504.187227830162;11600.825987610024;11703.76592468163;12489.437975290952;12498.812517812423;12560.685982850502 04:42:57 INFO - PROCESS | 8012 | |3;mootools.html;1578.4712121439318;1578.889477736558;1582.4145066325461;1603.8476344747248;1610.1868556379034;10609.098226650734;11288.830667539993;11293.774124517504;11296.774064518704;11298.209125361218;11042.503087361069;11386.146039047084;11513.021393181569;11533.365664888448;11552.65342039738;2560.2319304208754;2594.818362714611;2600.6489123968213;2602.3103877472486;2605.452854900473;2456.6069428891383;2494.1769216158714;2531.962020569693;2533.3793220660873;2533.898644054236;2421.092090466075;2479.2810085075307;2551.591745320749;2562.5387430262545;2563.1541591274927;2439.073152202152;2485.515324511721;2497.126005897939;2514.6856642919633;2525.1919385796555;2370.881455927197;2393.868337241451;2402.903883844644;2404.483036147237;2409.4337830609793;11124.443777811077;11165.888341116648;11213.831792523119;11234.269772464846;11240.831387529193;5764.51001664859;5889.9705501472645;5890.263717035371;5896.911546326808;5903.734331955073;3509.3332266869215;3518.8592456301717;3527.5766907971206;3606.2246616977213;3671.1923376857317;1387.6322774464675;1392.8607139286091;1430.9141451512942;1440.0639584270205;1462.5393001204693;16924.40764573234;17401.129943502776;17977.910110449495;18046.18792154343;18256.087195640164;4875.171220892456;4937.086638971802;4972.030454061495;4983.6760610560195;5076.796928122833;13107.606771796862;13133.408996595175;13145.277009764555;13151.01367397449;13154.4080516377;6070.696465176812;6096.69516524172;6115.755369785159;6118.174046503754;6119.877602447926;5454.7818087276855;5487.5884308677005;5560.138178582326;5618.606697531215;5633;4027.7381970172432;4176.394422808737;4194.182134483746;4246.554111818276;4252.362145678173;1052.5053224984244;1052.8631277933819;1061.5382308695741;1064.9574017039386;1069.641670040545;1055.1664185293532;1064.2762921213648;1071.1270314693656;1076.6931424543968;1083.4691001409253;6877.312268773183;6947.930520694829;7026.683799229047;7137.964310178416;7164.749233776897;1021.269792098653;1025.3130402630256;1035.8549803027581;1065.174489770434;1100.8128618134776;4605.884852878705;4718.551737584924;4751.64362672801;4783.282507623884;4863.465018847924;14258;14778.18719970412;14788.704225915422;14820.481283155037;14865.2567371631;12093;13432.731345373038;13961.092528985584;14486.203258820655;14517.637059073397;8854.070322616162;10276.486175691185;10561.683149505527;10624.681259562225;10636.41499717523;7014.283016429966;7114.537555058904;7267.963660181666;7285.599292038777;7312.7440539582985;13094.541691040768;13238.536651217546;13306.13510121839;13338.93330533341;13356.732865342834;12447.190932589352;12553.309567973849;12557.309347985949;13309.733805324033;13330.466781329027;9915.603375864885;9971.40171589707;10168.796624067329;10171.694849154537;10182.338148020355;10734.570617175537;10767.730806729895;10911.78176436451;10922.29005114665;10924.508397122308;8881.067487913677;8890.155435233642;8912.688055918012;8937.195652391316;9032.14194651507;9099.454032758056;9105.226055785333;9248.121428464285;9259.76850578741;9276.443413395218;8140.185981401813;8162.347012238888;8220.547869866976;8258.504489730636;8262.917370826215;6496.480281577557;6499.642519661464;6518.478521718156;6670.099536562502;6786.558873673195;6679.298673639198;6713.295104014008;6804.82987925286;6872.381485666314;6970.23327433992 04:42:57 INFO - PROCESS | 8012 | |4;prototype.html;421.7448443691567;436.10380667727804;440.5550394101956;442.8095918754934;442.98892527686803;5080.679023453901;5277.208418737187;5333;5351.384590772062;5351.849352389236;5149.094834911089;5223.216517522374;5246.9012395042;5251.55361794247;5257.658252213603;4326.913461730764;4483.977580112095;4484.618807401374;4492.191405547001;4495.842645507408;4492.663050271226;4492.742032230981;4495.213337665912;4497.955020449786;4504.121696269229;4382.386465894777;4402.82388704453;4458.375827384169;4510.842120525782;4519.683622146451;4419.895026243439;4456.910861782746;4475.59719625232;4531.161735079021;4533.252013417782;4161.479815023122;4173.457450531411;4178.477690288714;4179.352200408942;4189.874303770892;5133.512316329943;5173.8876141629735;5182.222666600002;5185.248139019821;5235.764390602432;4865.7105866945285;5038.161071209019;5150.536451719326;5203.869903252449;5208.479152084799;5462.754176062087;5473;5483.533899618537;5483.7806487740445;5512.228288039678;4639.605633521155;4648.1168577970075;4650.930236046462;4661.254199328091;4697.412823397075;5381.4349493303425;5530.681591045341;5540.889182216333;5636.971815140939;5773.653580785166;4613.169629466661;4691.202495575761;4731.705123015335;4763.880902977453;4785.545373189611;4819.807207711722;4827.975860120677;4845.854624361275;4852.369192005087;4861.295112208781;4831.347768051339;4840.6127509799135;5103.545489535464;5107.795688172431;5119.6160287978555;5400.540954018874;5409.783608655688;5462.371827239918;5488.615796894259;5555.777768889199;1640.286475383212;1649.8038921781613;1663.6672665466956;1670.0043448079427;1671.7910261217348;1263.1978693529675;1264.886899528409;1299.811527328532;1314.5793346129146;1316.2036967634442;5370.3287089113865;5397.7571009304675;5404.91892621611;5461.535769459561;5477.7261136943;5652.445577466147;5675.5459563234845;5684.459976302244;5684.886302274014;5689.630174038674;5277.604179686539;5374.435684253175;5377.220303056035;5424.62027658068;5477.808276710376;2917.7519910807396;2944.4994350960387;2945.335885224841;2961.8815247390294;2969.8663560139844;5561.805336813273;5834.854128646818;5845.006348920694;5882.3529411764675;5896.761680047152;5702.401247868914;5708.457696518824;5724.652892314214;5745.500707192385;5784.971075144597;5791.218185544982;5795.797147099831;5806.999999999915;5819.82540523785;5874.530037597067;5336.893262134813;5525.392206857323;5597.832065037893;5633.267675202362;5651.660900345993;5483.533899618417;5515.889682206253;5522.889542209214;5536.861578460571;5541.806036788693;5628.127640215773;5705.172749951317;5794.159846822103;5810.941890581209;5836.482514546164;4639.907201855876;4672.252439609646;4724.00795832879;4739.739314337607;4740.78666460017;5402.243685884058;5551.666899986014;5689.260396148474;5694.380584930978;5726.255586773693;5524.171374293888;5533.806316778893;5571.07797809755;5573.303337082864;5593.4126916674795;5493.807716729895;5521.641093328921;5533.861653458695;5556.388797232382;5594.608377413542;5366.6779993200535;5400.62195646301;5475.589330800286;5511.614187006871;5542.3626282977975;5555.30558680165;5560.193771903132;5560.944390556205;5583.330000399978;5626.268585084076;5377.193420986883;5382.15605954644;5515.69663668486;5545.3622833374675;5565.471280228372 04:42:57 INFO - PROCESS | 8012 | |5;yui.html;856.0668870930684;886.8226354729056;923.116841643048;931.4550987672209;932.5011119051304;16813.32746690134;17015.744763828523;17134.742978855313;17311.047892365914;18906.432807015794;16804.57988550287;17011.489655310328;17188.570285742833;17560.209790559424;17715.46853594391;895.9372843900929;905.8731777551149;922.5064590444114;927.082188633255;933.5752232734089;932.0865551759246;932.8414169591152;933.621883137327;934.2385955446324;935.1817159985013;978.9363691360039;979.6375341123794;980.3382716666257;980.5342462330407;980.9754756131083;976.4629453800381;977.022977022977;978.3102912446743;978.9265805064578;979.094337737597;713.7715930902114;713.989290160648;714.0895358418059;714.639107250835;714.7677004973405;18134.365297214536;18150.45548633543;18495.815041849677;19133.1390087445;19321.710174347398;15067;15582.298796554182;15705.685886282325;15846.207689615474;16115.19424028794;13124.737505249841;13300.135491193041;14146.221957792317;14550.417983280657;15537.223138843012;4922.26166075088;4948.8762780930765;4981.9750901245625;5184.766685499161;5186.50728180826;49015.754921225525;57112.71443642755;77340;83661.58169209115;95001.52499237529;12778.297193654253;12917.677058073436;13029.674258143432;13224.73550528984;13372.33138343079;21014.47463813417;24406.26781196567;24874.5025099497;25051.373715657253;25211.369715757253;9294.535273236312;9571.952140239255;9632.90367096334;9723.465209413409;9731.270154738422;5002.799888004512;5062.443131255559;5063.240513922941;5078.060558796635;5144.43411224765;3911.6088391161225;4013.658838998718;4013.69897257701;4017.116234428421;4019.8995025124023;691.6783695581579;703.0298188499837;705.7247673407376;707.5860621536356;710.8258476673249;660.0528241972688;691.498663468991;697.6790676288863;698.1099098649263;705.9047028651066;10849.294795838245;11349;11528.654140375802;11578.594749183738;11727.648170554898;843.3379796859558;848.1433751910491;860.7284000752761;866.0862789756741;875.1379890807549;5523.7790488380015;5644.92381099735;5650.576206784508;5658.122990936411;5737.540996720252;72237.27762722305;85752.14247857567;86158.56920715356;87106.56446717726;89965.55017224872;76766.23233767702;77779.61110194413;79192.60403697945;79468.20531794724;79649;51822.74088629533;54229.45770542244;57003.714981424826;65158.88205399799;65686.34313656898;12105.75788484243;12423.192492487959;12486.218575870103;12685.746285074063;12751.298678572768;43524.34713479237;43874.12251755011;45050;45845.31232031455;46020.30969535393;50924.490755091974;51106;51187.488125118274;51193.488065120364;52551.47448525466;13893.166410015432;13969.93015034959;14030.508932187324;14163.221022843842;14274;16306.429274975319;16334.509964701077;16448.424305149263;16475;17024.23390947435;15747.527574172793;15762.527124186292;15817.604559886095;15821.841781582498;16396.180190990162;15601.063936163866;15621;15655.530334089995;15954.122523261332;16059.27733251983;15013.699726005638;15391.307391167647;15542.844571554591;15708.68582628364;15783.131927744083;10507.15942724565;10568.313059651098;10591.841122383325;10942.835857462303;11401.429928503707;12607.558735444216;12658.556950506689;12787.424565894744;12828.358582071045;12873.549425770054 04:42:57 INFO - PROCESS | 8012 | __end_tp_report 04:42:57 INFO - PROCESS | 8012 | __start_cc_report 04:42:57 INFO - PROCESS | 8012 | _x_x_mozilla_cycle_collect,1429 04:42:57 INFO - PROCESS | 8012 | __end_cc_report 04:42:57 INFO - PROCESS | 8012 | __startTimestamp1495453377615__endTimestamp 04:42:57 INFO - PROCESS | 8012 | 04:42:57 INFO - PROCESS | 8012 | ------- Summary: start ------- 04:42:57 INFO - PROCESS | 8012 | Number of tests: 6 04:42:57 INFO - PROCESS | 8012 | 04:42:57 INFO - PROCESS | 8012 | [#0] dojo.html Cycles:165 Average:5697.59 Median:5924.20 stddev:631.23 (10.7%) stddev-sans-first:605.96 04:42:57 INFO - PROCESS | 8012 | Values: 3360.7 3382.7 3396.0 3423.8 3441.3 5690.4 5720.6 5758.5 5785.2 5786.2 5704.4 5785.4 5801.7 5805.2 5814.0 5275.4 5291.8 5326.7 5331.0 5375.3 5074.5 5115.1 5343.6 5369.9 5371.5 5235.1 5253.7 5263.3 5280.3 5290.5 5347.5 5359.0 5359.0 5360.1 5361.6 5061.2 5204.1 5251.9 5328.0 5333.5 5594.5 5595.7 5700.9 5704.9 5712.8 6147.0 6166.4 6174.5 6176.9 6182.8 6182.2 6182.7 6215.9 6219.7 6230.3 5566.8 5592.0 5730.3 5754.8 5773.8 6246.3 6251.4 6254.2 6255.4 6256.9 5990.4 6010.5 6044.1 6045.9 6061.5 5896.4 5947.4 6062.1 6096.7 6110.7 6108.3 6109.5 6117.9 6118.3 6125.5 5869.4 5907.9 5908.8 6033.2 6141.4 4662.0 4668.4 4708.8 4717.8 4730.0 4078.6 4078.9 4104.2 4179.5 4190.4 5924.2 5932.9 5940.3 5953.7 5983.5 6134.3 6149.4 6184.3 6187.1 6187.2 5721.1 5925.1 5936.2 5940.3 5943.6 5146.8 5164.9 5205.3 5251.2 5254.6 6356.0 6371.7 6391.9 6407.2 6408.0 6172.1 6203.2 6211.7 6214.5 6230.4 6133.9 6174.4 6202.7 6203.4 6254.6 6000.9 6025.5 6028.7 6033.7 6056.5 6123.4 6135.0 6136.8 6137.5 6146.0 5754.7 5813.8 5933.8 5944.9 5969.1 6012.6 6023.7 6024.4 6048.9 6064.6 5942.0 5989.3 5996.8 5999.7 6004.9 5731.4 5762.2 5792.4 5800.7 5804.2 5832.1 5876.9 5876.9 5879.1 5883.6 04:42:57 INFO - PROCESS | 8012 | 04:42:57 INFO - PROCESS | 8012 | [#1] ext.html Cycles:180 Average:43294.49 Median:30142.47 stddev:69020.70 (229.0%) stddev-sans-first:69140.43 04:42:57 INFO - PROCESS | 8012 | Values: 759.6 824.9 843.8 898.7 911.5 31285.0 44354.8 45214.8 45238.8 45306.0 42844.8 43077.4 43151.6 46978.0 47003.3 7847.9 9022.2 9029.5 9159.5 9167.7 7804.8 10583.0 10702.2 10805.9 10813.0 10882.1 10921.3 10937.7 10953.9 10955.3 10871.6 10892.9 10895.8 10898.3 10909.2 10703.1 10714.0 10765.0 10793.0 10808.8 42378.8 42390.6 42668.8 42677.6 42772.1 4277.1 4339.1 4360.5 4498.1 4525.0 30151.2 30157.5 30290.8 30876.7 32398.0 4425.6 4444.7 4495.1 4509.7 4522.5 225378.0 226019.0 226360.0 226541.0 226957.0 53244.2 53821.5 53857.2 53876.2 53914.5 55264.4 55601.0 55659.7 55686.4 55812.4 13854.5 13972.7 13987.4 14004.2 14005.8 11612.0 11841.5 13638.7 13651.2 13674.1 13042.3 13296.7 13446.7 13567.6 13895.4 5531.7 5626.9 5640.1 5661.6 5694.4 996.7 1002.9 1006.1 1014.6 1024.6 29140.7 29184.1 29464.9 29493.6 29495.4 1074.9 1078.7 1090.6 1094.0 1097.2 14563.0 15414.0 15524.2 15541.3 15657.0 286545.0 287125.0 287564.0 287628.0 287869.0 56519.0 56616.0 56628.2 56631.7 56650.2 1490.9 1530.4 1531.3 1532.0 1536.2 27843.6 28395.3 28606.7 28770.0 29080.6 36724.8 36886.8 37042.0 37098.3 37168.3 275359.0 277015.0 278044.0 278518.0 278662.0 25672.6 25977.0 29439.1 30265.7 31041.7 36840.0 37154.0 37265.6 39855.0 40437.4 31432.4 31548.5 31661.2 31703.4 31765.2 31038.7 31382.5 31572.0 31702.7 31833.4 35334.5 35462.5 35474.0 35674.0 36333.1 29334.3 29574.6 29735.1 29850.0 30133.7 23592.9 24946.0 25138.9 25443.2 25495.4 04:42:57 INFO - PROCESS | 8012 | 04:42:57 INFO - PROCESS | 8012 | [#2] jquery.html Cycles:180 Average:37916.72 Median:22947.31 stddev:108161.72 (471.3%) stddev-sans-first:108428.51 04:42:57 INFO - PROCESS | 8012 | Values: 428.3 445.2 445.2 456.6 467.2 19984.9 21583.4 22018.4 22145.3 22261.9 21861.9 22370.7 22804.5 22929.4 22965.2 6660.3 6878.4 6934.5 7295.4 7609.5 7221.0 7561.7 7594.7 7606.7 7608.4 7627.1 7660.4 7662.0 7662.8 7665.7 7457.2 7486.0 7542.4 7577.3 7578.3 7234.5 7374.8 7377.2 7511.7 7588.5 23362.0 23512.2 25967.5 26617.3 26895.9 3033.5 3146.6 3151.0 3224.5 3225.5 15707.4 16661.0 16695.7 16888.0 17263.3 1959.6 2007.8 2011.3 2012.7 2053.3 116374.0 116390.4 116916.0 119016.0 120800.0 17905.2 18104.5 18294.5 18453.3 18598.7 31804.4 31822.0 31842.5 32171.0 32230.8 10264.3 10320.6 10380.3 10495.7 10562.9 8707.7 8734.9 8817.4 9057.0 9071.3 9016.2 9313.6 9313.9 9427.4 9507.7 3823.4 3863.0 3954.6 3975.6 4049.0 944.2 949.4 963.2 963.5 994.6 20860.4 21667.2 21731.5 21750.8 21771.2 960.1 961.5 966.7 968.5 981.9 11477.7 11608.2 11792.8 11822.8 11919.9 641925.0 651322.0 655584.0 656416.0 674026.0 80420.0 95603.0 120802.0 122985.4 128287.0 1410.6 1438.3 1468.1 1471.4 1481.3 19005.2 19326.0 19377.1 19511.3 19601.8 50695.7 51219.5 53072.7 53567.5 54428.7 71706.6 72855.3 73458.0 73932.6 74385.0 12334.6 12404.8 12578.6 12580.5 12596.6 14176.0 14299.3 14321.7 14447.9 14567.3 12474.0 12768.0 12784.0 12948.4 13116.3 9756.4 11630.5 11712.5 11886.1 12072.2 12251.4 12376.7 12395.8 12680.3 12800.9 12023.4 12148.6 12304.2 12455.0 12504.2 11600.8 11703.8 12489.4 12498.8 12560.7 04:42:57 INFO - PROCESS | 8012 | 04:42:57 INFO - PROCESS | 8012 | [#3] mootools.html Cycles:180 Average:7163.99 Median:2482.40 stddev:4518.14 (182.0%) stddev-sans-first:4511.32 04:42:57 INFO - PROCESS | 8012 | Values: 1578.5 1578.9 1582.4 1603.8 1610.2 10609.1 11288.8 11293.8 11296.8 11298.2 11042.5 11386.1 11513.0 11533.4 11552.7 2560.2 2594.8 2600.6 2602.3 2605.5 2456.6 2494.2 2532.0 2533.4 2533.9 2421.1 2479.3 2551.6 2562.5 2563.2 2439.1 2485.5 2497.1 2514.7 2525.2 2370.9 2393.9 2402.9 2404.5 2409.4 11124.4 11165.9 11213.8 11234.3 11240.8 5764.5 5890.0 5890.3 5896.9 5903.7 3509.3 3518.9 3527.6 3606.2 3671.2 1387.6 1392.9 1430.9 1440.1 1462.5 16924.4 17401.1 17977.9 18046.2 18256.1 4875.2 4937.1 4972.0 4983.7 5076.8 13107.6 13133.4 13145.3 13151.0 13154.4 6070.7 6096.7 6115.8 6118.2 6119.9 5454.8 5487.6 5560.1 5618.6 5633.0 4027.7 4176.4 4194.2 4246.6 4252.4 1052.5 1052.9 1061.5 1065.0 1069.6 1055.2 1064.3 1071.1 1076.7 1083.5 6877.3 6947.9 7026.7 7138.0 7164.7 1021.3 1025.3 1035.9 1065.2 1100.8 4605.9 4718.6 4751.6 4783.3 4863.5 14258.0 14778.2 14788.7 14820.5 14865.3 12093.0 13432.7 13961.1 14486.2 14517.6 8854.1 10276.5 10561.7 10624.7 10636.4 7014.3 7114.5 7268.0 7285.6 7312.7 13094.5 13238.5 13306.1 13338.9 13356.7 12447.2 12553.3 12557.3 13309.7 13330.5 9915.6 9971.4 10168.8 10171.7 10182.3 10734.6 10767.7 10911.8 10922.3 10924.5 8881.1 8890.2 8912.7 8937.2 9032.1 9099.5 9105.2 9248.1 9259.8 9276.4 8140.2 8162.3 8220.5 8258.5 8262.9 6496.5 6499.6 6518.5 6670.1 6786.6 6679.3 6713.3 6804.8 6872.4 6970.2 04:42:57 INFO - PROCESS | 8012 | 04:42:57 INFO - PROCESS | 8012 | [#4] prototype.html Cycles:180 Average:4819.88 Median:5351.62 stddev:1267.49 (23.7%) stddev-sans-first:1227.31 04:42:57 INFO - PROCESS | 8012 | Values: 421.7 436.1 440.6 442.8 443.0 5080.7 5277.2 5333.0 5351.4 5351.8 5149.1 5223.2 5246.9 5251.6 5257.7 4326.9 4484.0 4484.6 4492.2 4495.8 4492.7 4492.7 4495.2 4498.0 4504.1 4382.4 4402.8 4458.4 4510.8 4519.7 4419.9 4456.9 4475.6 4531.2 4533.3 4161.5 4173.5 4178.5 4179.4 4189.9 5133.5 5173.9 5182.2 5185.2 5235.8 4865.7 5038.2 5150.5 5203.9 5208.5 5462.8 5473.0 5483.5 5483.8 5512.2 4639.6 4648.1 4650.9 4661.3 4697.4 5381.4 5530.7 5540.9 5637.0 5773.7 4613.2 4691.2 4731.7 4763.9 4785.5 4819.8 4828.0 4845.9 4852.4 4861.3 4831.3 4840.6 5103.5 5107.8 5119.6 5400.5 5409.8 5462.4 5488.6 5555.8 1640.3 1649.8 1663.7 1670.0 1671.8 1263.2 1264.9 1299.8 1314.6 1316.2 5370.3 5397.8 5404.9 5461.5 5477.7 5652.4 5675.5 5684.5 5684.9 5689.6 5277.6 5374.4 5377.2 5424.6 5477.8 2917.8 2944.5 2945.3 2961.9 2969.9 5561.8 5834.9 5845.0 5882.4 5896.8 5702.4 5708.5 5724.7 5745.5 5785.0 5791.2 5795.8 5807.0 5819.8 5874.5 5336.9 5525.4 5597.8 5633.3 5651.7 5483.5 5515.9 5522.9 5536.9 5541.8 5628.1 5705.2 5794.2 5810.9 5836.5 4639.9 4672.3 4724.0 4739.7 4740.8 5402.2 5551.7 5689.3 5694.4 5726.3 5524.2 5533.8 5571.1 5573.3 5593.4 5493.8 5521.6 5533.9 5556.4 5594.6 5366.7 5400.6 5475.6 5511.6 5542.4 5555.3 5560.2 5560.9 5583.3 5626.3 5377.2 5382.2 5515.7 5545.4 5565.5 04:42:57 INFO - PROCESS | 8012 | 04:42:57 INFO - PROCESS | 8012 | [#5] yui.html Cycles:180 Average:18689.54 Median:26969.01 stddev:22756.23 (84.4%) stddev-sans-first:22780.67 04:42:57 INFO - PROCESS | 8012 | Values: 856.1 886.8 923.1 931.5 932.5 16813.3 17015.7 17134.7 17311.0 18906.4 16804.6 17011.5 17188.6 17560.2 17715.5 895.9 905.9 922.5 927.1 933.6 932.1 932.8 933.6 934.2 935.2 978.9 979.6 980.3 980.5 981.0 976.5 977.0 978.3 978.9 979.1 713.8 714.0 714.1 714.6 714.8 18134.4 18150.5 18495.8 19133.1 19321.7 15067.0 15582.3 15705.7 15846.2 16115.2 13124.7 13300.1 14146.2 14550.4 15537.2 4922.3 4948.9 4982.0 5184.8 5186.5 49015.8 57112.7 77340.0 83661.6 95001.5 12778.3 12917.7 13029.7 13224.7 13372.3 21014.5 24406.3 24874.5 25051.4 25211.4 9294.5 9572.0 9632.9 9723.5 9731.3 5002.8 5062.4 5063.2 5078.1 5144.4 3911.6 4013.7 4013.7 4017.1 4019.9 691.7 703.0 705.7 707.6 710.8 660.1 691.5 697.7 698.1 705.9 10849.3 11349.0 11528.7 11578.6 11727.6 843.3 848.1 860.7 866.1 875.1 5523.8 5644.9 5650.6 5658.1 5737.5 72237.3 85752.1 86158.6 87106.6 89965.6 76766.2 77779.6 79192.6 79468.2 79649.0 51822.7 54229.5 57003.7 65158.9 65686.3 12105.8 12423.2 12486.2 12685.7 12751.3 43524.3 43874.1 45050.0 45845.3 46020.3 50924.5 51106.0 51187.5 51193.5 52551.5 13893.2 13969.9 14030.5 14163.2 14274.0 16306.4 16334.5 16448.4 16475.0 17024.2 15747.5 15762.5 15817.6 15821.8 16396.2 15601.1 15621.0 15655.5 15954.1 16059.3 15013.7 15391.3 15542.8 15708.7 15783.1 10507.2 10568.3 10591.8 10942.8 11401.4 12607.6 12658.6 12787.4 12828.4 12873.5 04:42:57 INFO - PROCESS | 8012 | -------- Summary: end -------- 04:42:57 INFO - PROCESS | 8012 | 04:42:58 INFO - TEST-INFO | 8012: exit 0 04:42:58 INFO - TEST-OK | dromaeo_css | took 1116542ms 04:42:58 INFO - TEST-START | kraken 04:42:58 INFO - operating with platform_type : linux_ 04:42:58 INFO - Initialising browser for kraken test... 04:42:58 INFO - TEST-INFO | started process 8310 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK0nGBB/profile http://localhost:49279/getInfo.html) 04:43:02 INFO - PROCESS | 8310 | __metrics Screen width/height:1600/1200 04:43:02 INFO - PROCESS | 8310 | colorDepth:24 04:43:02 INFO - PROCESS | 8310 | Browser inner width/height: 1024/697 04:43:02 INFO - PROCESS | 8310 | __metrics 04:43:03 INFO - PROCESS | 8310 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:43:03 INFO - PROCESS | 8310 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:43:04 INFO - TEST-INFO | 8310: exit 0 04:43:04 INFO - Browser initialized. 04:43:04 INFO - Running cycle 1/1 for kraken test... 04:43:04 INFO - TEST-INFO | started process 8404 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK0nGBB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:43:16 INFO - PROCESS | 8404 | RSS: Main: 141725696 04:43:16 INFO - PROCESS | 8404 | 04:43:18 INFO - PROCESS | 8404 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 04:43:19 INFO - PROCESS | 8404 | RSS: Main: 183619584 04:43:19 INFO - PROCESS | 8404 | 04:43:22 INFO - PROCESS | 8404 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 04:43:22 INFO - PROCESS | 8404 | RSS: Main: 173621248 04:43:22 INFO - PROCESS | 8404 | 04:43:25 INFO - PROCESS | 8404 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 04:43:26 INFO - PROCESS | 8404 | RSS: Main: 265154560 04:43:26 INFO - PROCESS | 8404 | 04:43:28 INFO - PROCESS | 8404 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 04:43:28 INFO - PROCESS | 8404 | RSS: Main: 170962944 04:43:28 INFO - PROCESS | 8404 | 04:43:30 INFO - PROCESS | 8404 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:43:31 INFO - PROCESS | 8404 | RSS: Main: 173858816 04:43:31 INFO - PROCESS | 8404 | 04:43:34 INFO - PROCESS | 8404 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 04:43:34 INFO - PROCESS | 8404 | RSS: Main: 209518592 04:43:34 INFO - PROCESS | 8404 | 04:43:38 INFO - PROCESS | 8404 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 04:43:38 INFO - PROCESS | 8404 | RSS: Main: 211742720 04:43:38 INFO - PROCESS | 8404 | 04:43:41 INFO - PROCESS | 8404 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 04:43:42 INFO - PROCESS | 8404 | RSS: Main: 211030016 04:43:42 INFO - PROCESS | 8404 | 04:43:43 INFO - PROCESS | 8404 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:43:44 INFO - PROCESS | 8404 | RSS: Main: 173776896 04:43:44 INFO - PROCESS | 8404 | 04:43:46 INFO - PROCESS | 8404 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:43:46 INFO - PROCESS | 8404 | RSS: Main: 180527104 04:43:46 INFO - PROCESS | 8404 | 04:43:48 INFO - PROCESS | 8404 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:43:49 INFO - PROCESS | 8404 | RSS: Main: 190074880 04:43:49 INFO - PROCESS | 8404 | 04:43:51 INFO - PROCESS | 8404 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:43:52 INFO - PROCESS | 8404 | RSS: Main: 200531968 04:43:52 INFO - PROCESS | 8404 | 04:43:55 INFO - PROCESS | 8404 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:43:55 INFO - PROCESS | 8404 | RSS: Main: 195645440 04:43:55 INFO - PROCESS | 8404 | 04:43:57 INFO - PROCESS | 8404 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 04:43:57 INFO - PROCESS | 8404 | RSS: Main: 247480320 04:43:57 INFO - PROCESS | 8404 | 04:43:57 INFO - PROCESS | 8404 | __start_tp_report 04:43:57 INFO - PROCESS | 8404 | _x_x_mozilla_page_load 04:43:57 INFO - PROCESS | 8404 | _x_x_mozilla_page_load_details 04:43:57 INFO - PROCESS | 8404 | |i|pagename|runs| 04:43:57 INFO - PROCESS | 8404 | |0;ai-astar;103;112;112;111;111;112;111;111;111;112 04:43:57 INFO - PROCESS | 8404 | |1;audio-beat-detection;136;114;116;152;118;116;115;117;132;116 04:43:57 INFO - PROCESS | 8404 | |2;audio-dft;159;162;160;161;159;160;160;159;161;161 04:43:57 INFO - PROCESS | 8404 | |3;audio-fft;75;76;76;107;75;77;75;75;95;75 04:43:57 INFO - PROCESS | 8404 | |4;audio-oscillator;82;82;107;81;81;82;99;82;83;102 04:43:57 INFO - PROCESS | 8404 | |5;imaging-gaussian-blur;112;112;112;113;113;113;113;113;113;113 04:43:57 INFO - PROCESS | 8404 | |6;imaging-darkroom;146;146;147;146;146;147;147;146;146;147 04:43:57 INFO - PROCESS | 8404 | |7;imaging-desaturate;93;94;94;94;93;93;93;94;94;94 04:43:57 INFO - PROCESS | 8404 | |8;json-parse-financial;58;53;54;53;53;54;55;55;53;53 04:43:57 INFO - PROCESS | 8404 | |9;json-stringify-tinderbox;52;53;53;52;53;52;53;52;53;53 04:43:57 INFO - PROCESS | 8404 | |10;stanford-crypto-aes;81;75;76;75;82;76;76;76;74;75 04:43:57 INFO - PROCESS | 8404 | |11;stanford-crypto-ccm;129;121;128;120;120;120;122;139;173;133 04:43:57 INFO - PROCESS | 8404 | |12;stanford-crypto-pbkdf2;164;170;158;162;164;161;161;158;162;159 04:43:57 INFO - PROCESS | 8404 | |13;stanford-crypto-sha256-iterative;59;59;59;60;60;60;60;59;62;59 04:43:57 INFO - PROCESS | 8404 | __end_tp_report 04:43:57 INFO - PROCESS | 8404 | __start_cc_report 04:43:57 INFO - PROCESS | 8404 | _x_x_mozilla_cycle_collect,1650 04:43:57 INFO - PROCESS | 8404 | __end_cc_report 04:43:57 INFO - PROCESS | 8404 | __startTimestamp1495453437708__endTimestamp 04:43:57 INFO - PROCESS | 8404 | 04:43:57 INFO - PROCESS | 8404 | ------- Summary: start ------- 04:43:57 INFO - PROCESS | 8404 | Number of tests: 14 04:43:57 INFO - PROCESS | 8404 | 04:43:57 INFO - PROCESS | 8404 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.50 stddev:2.72 (2.4%) stddev-sans-first:0.53 04:43:57 INFO - PROCESS | 8404 | Values: 103.0 112.0 112.0 111.0 111.0 112.0 111.0 111.0 111.0 112.0 04:43:57 INFO - PROCESS | 8404 | 04:43:57 INFO - PROCESS | 8404 | [#1] audio-beat-detection Cycles:10 Average:123.20 Median:117.50 stddev:12.66 (10.8%) stddev-sans-first:12.56 04:43:57 INFO - PROCESS | 8404 | Values: 136.0 114.0 116.0 152.0 118.0 116.0 115.0 117.0 132.0 116.0 04:43:57 INFO - PROCESS | 8404 | 04:43:57 INFO - PROCESS | 8404 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.50 stddev:1.03 (0.6%) stddev-sans-first:1.00 04:43:57 INFO - PROCESS | 8404 | Values: 159.0 162.0 160.0 161.0 159.0 160.0 160.0 159.0 161.0 161.0 04:43:57 INFO - PROCESS | 8404 | 04:43:57 INFO - PROCESS | 8404 | [#3] audio-fft Cycles:10 Average:80.60 Median:75.50 stddev:11.14 (14.8%) stddev-sans-first:11.63 04:43:57 INFO - PROCESS | 8404 | Values: 75.0 76.0 76.0 107.0 75.0 77.0 75.0 75.0 95.0 75.0 04:43:57 INFO - PROCESS | 8404 | 04:43:57 INFO - PROCESS | 8404 | [#4] audio-oscillator Cycles:10 Average:88.10 Median:82.00 stddev:10.25 (12.5%) stddev-sans-first:10.63 04:43:57 INFO - PROCESS | 8404 | Values: 82.0 82.0 107.0 81.0 81.0 82.0 99.0 82.0 83.0 102.0 04:43:57 INFO - PROCESS | 8404 | 04:43:57 INFO - PROCESS | 8404 | [#5] imaging-gaussian-blur Cycles:10 Average:112.70 Median:113.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 04:43:57 INFO - PROCESS | 8404 | Values: 112.0 112.0 112.0 113.0 113.0 113.0 113.0 113.0 113.0 113.0 04:43:57 INFO - PROCESS | 8404 | 04:43:57 INFO - PROCESS | 8404 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:43:57 INFO - PROCESS | 8404 | Values: 146.0 146.0 147.0 146.0 146.0 147.0 147.0 146.0 146.0 147.0 04:43:57 INFO - PROCESS | 8404 | 04:43:57 INFO - PROCESS | 8404 | [#7] imaging-desaturate Cycles:10 Average:93.60 Median:94.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 04:43:57 INFO - PROCESS | 8404 | Values: 93.0 94.0 94.0 94.0 93.0 93.0 93.0 94.0 94.0 94.0 04:43:57 INFO - PROCESS | 8404 | 04:43:57 INFO - PROCESS | 8404 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:1.60 (3.0%) stddev-sans-first:0.87 04:43:57 INFO - PROCESS | 8404 | Values: 58.0 53.0 54.0 53.0 53.0 54.0 55.0 55.0 53.0 53.0 04:43:57 INFO - PROCESS | 8404 | 04:43:57 INFO - PROCESS | 8404 | [#9] json-stringify-tinderbox Cycles:10 Average:52.60 Median:53.00 stddev:0.52 (1.0%) stddev-sans-first:0.50 04:43:57 INFO - PROCESS | 8404 | Values: 52.0 53.0 53.0 52.0 53.0 52.0 53.0 52.0 53.0 53.0 04:43:57 INFO - PROCESS | 8404 | 04:43:57 INFO - PROCESS | 8404 | [#10] stanford-crypto-aes Cycles:10 Average:76.60 Median:76.00 stddev:2.67 (3.5%) stddev-sans-first:2.32 04:43:57 INFO - PROCESS | 8404 | Values: 81.0 75.0 76.0 75.0 82.0 76.0 76.0 76.0 74.0 75.0 04:43:57 INFO - PROCESS | 8404 | 04:43:57 INFO - PROCESS | 8404 | [#11] stanford-crypto-ccm Cycles:10 Average:130.50 Median:128.50 stddev:16.28 (12.7%) stddev-sans-first:17.26 04:43:57 INFO - PROCESS | 8404 | Values: 129.0 121.0 128.0 120.0 120.0 120.0 122.0 139.0 173.0 133.0 04:43:57 INFO - PROCESS | 8404 | 04:43:57 INFO - PROCESS | 8404 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.90 Median:162.00 stddev:3.57 (2.2%) stddev-sans-first:3.71 04:43:57 INFO - PROCESS | 8404 | Values: 164.0 170.0 158.0 162.0 164.0 161.0 161.0 158.0 162.0 159.0 04:43:57 INFO - PROCESS | 8404 | 04:43:57 INFO - PROCESS | 8404 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.70 Median:60.00 stddev:0.95 (1.6%) stddev-sans-first:0.97 04:43:57 INFO - PROCESS | 8404 | Values: 59.0 59.0 59.0 60.0 60.0 60.0 60.0 59.0 62.0 59.0 04:43:57 INFO - PROCESS | 8404 | -------- Summary: end -------- 04:43:57 INFO - PROCESS | 8404 | 04:43:58 INFO - TEST-INFO | 8404: exit 0 04:43:58 INFO - TEST-OK | kraken | took 60354ms 04:43:58 INFO - SUITE-END | took 1176s 04:43:58 INFO - Completed test suite (00:19:37) 04:43:58 INFO - javascript benchmark 04:43:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7897.39551860554, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3360.747943904207, 3382.6786455286756, 3396.049106250249, 3423.8116903570294, 3441.27733176033, 5690.430956904307, 5720.599558030939, 5758.510526605233, 5785.2189954356145, 5786.161006654038, 5704.429557044294, 5785.421457854212, 5801.680907550093, 5805.158252053449, 5814.040683287252, 5275.36695596528, 5291.814786482474, 5326.6537675051195, 5331.040412725727, 5375.3280839895015, 5074.492550744914, 5115.13042782726, 5343.572514198874, 5369.9463005370035, 5371.462853714617, 5235.083860324447, 5253.684778913258, 5263.34208223972, 5280.313559237294, 5290.470952904717, 5347.46525347466, 5358.955003774266, 5358.97320513395, 5360.142377219665, 5361.571074314045, 5061.16490779021, 5204.063268611649, 5251.947480525184, 5328.040952628526, 5333.493318134771, 5594.524465420444, 5595.720213989325, 5700.914486282709, 5704.857378565569, 5712.8000519982015, 6147.0, 6166.445019948226, 6174.475169610589, 6176.938230617681, 6182.752689892399, 6182.16116137596, 6182.69086545671, 6215.937840621581, 6219.68901554925, 6230.345813689542, 5566.777328906839, 5592.049351610236, 5730.34101078373, 5754.827355179351, 5773.769049237983, 6246.312905580383, 6251.374862513712, 6254.15568898202, 6255.374462553799, 6256.906146407808, 5990.371011043865, 6010.519158467312, 6044.123602077674, 6045.916716850294, 6061.515078793686, 5896.380880007623, 5947.405259474018, 6062.090686396988, 6096.69516524172, 6110.658101469769, 6108.32831767288, 6109.543923541144, 6117.857853872152, 6118.293648225464, 6125.509959203342, 5869.383714709894, 5907.940920590825, 5908.822735317947, 6033.215681961317, 6141.385861413823, 4661.95338046622, 4668.416447944007, 4708.8116475341285, 4717.787699553528, 4729.952700472952, 4078.5513593504693, 4078.898027549335, 4104.158647477319, 4179.456670632859, 4190.413342132104, 5924.20023296858, 5932.911006334908, 5940.31686356066, 5953.732082056318, 5983.461488466059, 6134.263888333428, 6149.446549810538, 6184.288806787187, 6187.133801267826, 6187.16473276102, 5721.141828725725, 5925.081612350093, 5936.198613187251, 5940.257467816523, 5943.64338139713, 5146.794128234828, 5164.870878227999, 5205.297284866495, 5251.159814429673, 5254.553362964114, 6355.999999999907, 6371.6814159290925, 6391.872162556723, 6407.231132264065, 6408.0, 6172.074188871705, 6203.16257305258, 6211.65835879031, 6214.5028397728975, 6230.408111229426, 6133.946794548555, 6174.44430001302, 6202.72087756043, 6203.379662033941, 6254.562180647311, 6000.909986350295, 6025.457708806229, 6028.6985650716415, 6033.728482218223, 6056.485198757979, 6123.387661234019, 6134.969325153345, 6136.846578835565, 6137.508999279958, 6145.9692701536205, 5754.741036653444, 5813.796517122049, 5933.821985340447, 5944.940550594439, 5969.104634304889, 6012.6392416455155, 6023.728932198149, 6024.427679370453, 6048.879022419439, 6064.605800622945, 5942.0, 5989.251343582052, 5996.760129594942, 5999.70001499932, 6004.909926351021, 5731.426857314235, 5762.164486149569, 5792.4497172768515, 5800.6809625471005, 5804.187413762161, 5832.096025116114, 5876.853078673067, 5876.941230587639, 5879.118132280192, 5883.646981181143], "value": 5656.142030288354, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [759.589821496392, 824.8556502612042, 843.8312337532493, 898.6719847255754, 911.5487833522408, 31285.0, 44354.778226108865, 45214.77392613032, 45238.773806130965, 45306.0, 42844.785776071156, 43077.35383969243, 43151.56848431515, 46978.0, 47003.29495057577, 7847.882281765778, 9022.188003079722, 9029.503377314246, 9159.45043297401, 9167.679131230409, 7804.804879877992, 10583.0, 10702.197335199891, 10805.945970270137, 10813.0, 10882.075023623001, 10921.344719316867, 10937.726556836064, 10953.890461095367, 10955.287906286107, 10871.619493317696, 10892.891071089267, 10895.782084358349, 10898.291611045297, 10909.1818113641, 10703.1437485001, 10714.0, 10765.03114719671, 10793.028627423491, 10808.837867431996, 42378.78810605958, 42390.57609423897, 42668.78665606683, 42677.57322426767, 42772.14455710868, 4277.123189746095, 4339.132173565268, 4360.454943132108, 4498.122866041123, 4525.027119169395, 30151.246218844484, 30157.547636785464, 30290.84854575735, 30876.691233087608, 32398.0, 4425.579569940851, 4444.666650001231, 4495.123450927071, 4509.714731301596, 4522.457305123374, 225378.0, 226019.0, 226360.0, 226541.0, 226956.99999999834, 53244.201336979975, 53821.46178538243, 53857.1921421179, 53876.191857122176, 53914.46085539173, 55264.44735552673, 55601.0, 55659.72170139123, 55686.44313556894, 55812.441875581535, 13854.515091971733, 13972.72054558903, 13987.440502379792, 14004.159750415009, 14005.789913151311, 11612.0, 11841.467133978991, 13638.727225455435, 13651.249181294925, 13674.111182773087, 13042.347882605833, 13296.73406531864, 13446.731065378637, 13567.59297221085, 13895.444182232597, 5531.723413829292, 5626.887462250732, 5640.097584386478, 5661.603687741818, 5694.373618901917, 996.656153627012, 1002.9147522460672, 1006.1296978114025, 1014.5688082564881, 1024.6311327921942, 29140.708592914223, 29184.124476265744, 29464.852675736485, 29493.557596636067, 29495.410091798043, 1074.8656417947757, 1078.703356576932, 1090.596479302663, 1093.9617113400993, 1097.2154909239932, 14563.0, 15414.0, 15524.223788810741, 15541.300641471162, 15657.0, 286545.0, 287125.0, 287564.0, 287628.0, 287869.0, 56519.0, 56616.0, 56628.15057774137, 56631.71684141635, 56650.150247746315, 1490.9478168264275, 1530.3801960206135, 1531.272645493404, 1532.0, 1536.170467947296, 27843.58234626442, 28395.290117746394, 28606.71393286124, 28770.0, 29080.56379154272, 36724.81637591795, 36886.815565922, 37042.0, 37098.258034839695, 37168.25663486769, 275359.0, 277015.0, 278044.0, 278518.0, 278662.0, 25672.614910776727, 25977.0, 29439.11682649524, 30265.697343026288, 31041.68958310388, 36840.0, 37154.0, 37265.6273437273, 39855.0, 40437.39343909785, 31432.37135257328, 31548.52677209798, 31661.208469787518, 31703.365932681678, 31765.20586985344, 31038.68961310358, 31382.52926206063, 31572.0, 31702.682973169973, 31833.36333273275, 35334.46998295079, 35462.46806297856, 35474.0, 35674.0, 36333.0916727084, 29334.26664333409, 29574.556381653863, 29735.107946761633, 29850.0, 30133.698663013965, 23592.88203558971, 24946.0021599134, 25138.874305628357, 25443.236702898943, 25495.36261593475], "value": 18543.60689192659, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.2890401932792, 445.1630933844372, 445.24086432632345, 456.63469224620303, 467.2174108368483, 19984.90007549962, 21583.352499425044, 22018.4495387615, 22145.33563993079, 22261.888690556545, 21861.890690546526, 22370.66444003341, 22804.54390912185, 22929.42676433086, 22965.19621813237, 6660.333966603337, 6878.380945714885, 6934.479914006444, 7295.416366690679, 7609.467337286392, 7221.025161603196, 7561.697532098709, 7594.658240379196, 7606.695732170707, 7608.353289970331, 7627.122880868688, 7660.4254680898875, 7661.961690191569, 7662.846743065135, 7665.693372265103, 7457.216992215821, 7485.989391432141, 7542.43431742616, 7577.318041376275, 7578.280063393969, 7234.457415693844, 7374.778756637309, 7377.151627562792, 7511.6995320187125, 7588.468807183499, 23362.010594654905, 23512.177073802333, 25967.480650386886, 26617.33456663599, 26895.86552067247, 3033.514637657964, 3146.5594816725675, 3151.038933125396, 3224.5002024685978, 3225.467797813358, 15707.371705131782, 16661.0, 16695.74956375655, 16888.0, 17263.309467621406, 1959.6276707425543, 2007.7791442941266, 2011.2960463837685, 2012.7081573171954, 2053.3326668832688, 116374.0, 116390.41804790922, 116916.0, 119016.0, 120799.99999999913, 17905.20947905199, 18104.547386315186, 18294.54263643393, 18453.261869525068, 18598.721019184723, 31804.363912722078, 31822.0, 31842.522362164586, 32171.0, 32230.83884580609, 10264.332818366782, 10320.587176512856, 10380.32527885685, 10495.737606559896, 10562.947185264025, 8707.6516939323, 8734.86897696535, 8817.382783205114, 9057.0, 9071.27429805614, 9016.23362014223, 9313.627454901864, 9313.906860931304, 9427.387219830689, 9507.66723164686, 3823.4073718573663, 3863.0, 3954.6440820326306, 3975.64666689974, 4049.0, 944.1927152284835, 949.378157306965, 963.1620490173453, 963.4604621412032, 994.627014869424, 20860.37418877436, 21667.24164654261, 21731.456713582287, 21750.782492174876, 21771.23800666969, 960.0846311608386, 961.5480724059681, 966.6616684160488, 968.5447839515416, 981.8527220916777, 11477.713057173638, 11608.187426880206, 11792.823107653392, 11822.763544729058, 11919.940400297943, 641925.0, 651322.0, 655584.0, 656416.0, 674026.0, 80420.0, 95603.0, 120802.0, 122985.38507307586, 128287.0, 1410.5627255550812, 1438.3239877257672, 1468.148473885144, 1471.3820195517908, 1481.3037872200048, 19005.239790408228, 19326.0, 19377.128029239, 19511.317103901296, 19601.803981959998, 50695.74652126716, 51219.48780512296, 53072.73463632657, 53567.4643253578, 54428.72785636046, 71706.61749641392, 72855.27144728485, 73458.0, 73932.63033684797, 74385.0, 12334.568290109803, 12404.75190496167, 12578.55975040869, 12580.496780128693, 12596.622101336974, 14176.0, 14299.285035748379, 14321.713565728836, 14447.927760361132, 14567.344469498687, 12474.0, 12768.0, 12784.0, 12948.417321220757, 13116.278604676834, 9756.365836220622, 11630.476628551567, 11712.472938717608, 11886.108541859569, 12072.154949153475, 12251.448684809384, 12376.690582735144, 12395.75208495843, 12680.302583358003, 12800.935995320337, 12023.398830058637, 12148.635540933787, 12304.200226985216, 12455.0, 12504.187227830162, 11600.825987610024, 11703.76592468163, 12489.437975290952, 12498.812517812423, 12560.685982850502], "value": 11694.792988490894, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1578.4712121439318, 1578.889477736558, 1582.4145066325461, 1603.8476344747248, 1610.1868556379034, 10609.098226650734, 11288.830667539993, 11293.774124517504, 11296.774064518704, 11298.209125361218, 11042.503087361069, 11386.146039047084, 11513.021393181569, 11533.365664888448, 11552.65342039738, 2560.2319304208754, 2594.818362714611, 2600.6489123968213, 2602.3103877472486, 2605.452854900473, 2456.6069428891383, 2494.1769216158714, 2531.962020569693, 2533.3793220660873, 2533.898644054236, 2421.092090466075, 2479.2810085075307, 2551.591745320749, 2562.5387430262545, 2563.1541591274927, 2439.073152202152, 2485.515324511721, 2497.126005897939, 2514.6856642919633, 2525.1919385796555, 2370.881455927197, 2393.868337241451, 2402.903883844644, 2404.483036147237, 2409.4337830609793, 11124.443777811077, 11165.888341116648, 11213.831792523119, 11234.269772464846, 11240.831387529193, 5764.51001664859, 5889.9705501472645, 5890.263717035371, 5896.911546326808, 5903.734331955073, 3509.3332266869215, 3518.8592456301717, 3527.5766907971206, 3606.2246616977213, 3671.1923376857317, 1387.6322774464675, 1392.8607139286091, 1430.9141451512942, 1440.0639584270205, 1462.5393001204693, 16924.40764573234, 17401.129943502776, 17977.910110449495, 18046.18792154343, 18256.087195640164, 4875.171220892456, 4937.086638971802, 4972.030454061495, 4983.6760610560195, 5076.796928122833, 13107.606771796862, 13133.408996595175, 13145.277009764555, 13151.01367397449, 13154.4080516377, 6070.696465176812, 6096.69516524172, 6115.755369785159, 6118.174046503754, 6119.877602447926, 5454.7818087276855, 5487.5884308677005, 5560.138178582326, 5618.606697531215, 5633.0, 4027.7381970172432, 4176.394422808737, 4194.182134483746, 4246.554111818276, 4252.362145678173, 1052.5053224984244, 1052.8631277933819, 1061.5382308695741, 1064.9574017039386, 1069.641670040545, 1055.1664185293532, 1064.2762921213648, 1071.1270314693656, 1076.6931424543968, 1083.4691001409253, 6877.312268773183, 6947.930520694829, 7026.683799229047, 7137.964310178416, 7164.749233776897, 1021.269792098653, 1025.3130402630256, 1035.8549803027581, 1065.174489770434, 1100.8128618134776, 4605.884852878705, 4718.551737584924, 4751.64362672801, 4783.282507623884, 4863.465018847924, 14258.0, 14778.18719970412, 14788.704225915422, 14820.481283155037, 14865.2567371631, 12093.0, 13432.731345373038, 13961.092528985584, 14486.203258820655, 14517.637059073397, 8854.070322616162, 10276.486175691185, 10561.683149505527, 10624.681259562225, 10636.41499717523, 7014.283016429966, 7114.537555058904, 7267.963660181666, 7285.599292038777, 7312.7440539582985, 13094.541691040768, 13238.536651217546, 13306.13510121839, 13338.93330533341, 13356.732865342834, 12447.190932589352, 12553.309567973849, 12557.309347985949, 13309.733805324033, 13330.466781329027, 9915.603375864885, 9971.40171589707, 10168.796624067329, 10171.694849154537, 10182.338148020355, 10734.570617175537, 10767.730806729895, 10911.78176436451, 10922.29005114665, 10924.508397122308, 8881.067487913677, 8890.155435233642, 8912.688055918012, 8937.195652391316, 9032.14194651507, 9099.454032758056, 9105.226055785333, 9248.121428464285, 9259.76850578741, 9276.443413395218, 8140.185981401813, 8162.347012238888, 8220.547869866976, 8258.504489730636, 8262.917370826215, 6496.480281577557, 6499.642519661464, 6518.478521718156, 6670.099536562502, 6786.558873673195, 6679.298673639198, 6713.295104014008, 6804.82987925286, 6872.381485666314, 6970.23327433992], "value": 5465.708008608309, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.7448443691567, 436.10380667727804, 440.5550394101956, 442.8095918754934, 442.98892527686803, 5080.679023453901, 5277.208418737187, 5333.0, 5351.384590772062, 5351.849352389236, 5149.094834911089, 5223.216517522374, 5246.9012395042, 5251.55361794247, 5257.658252213603, 4326.913461730764, 4483.977580112095, 4484.618807401374, 4492.191405547001, 4495.842645507408, 4492.663050271226, 4492.742032230981, 4495.213337665912, 4497.955020449786, 4504.121696269229, 4382.386465894777, 4402.82388704453, 4458.375827384169, 4510.842120525782, 4519.683622146451, 4419.895026243439, 4456.910861782746, 4475.59719625232, 4531.161735079021, 4533.252013417782, 4161.479815023122, 4173.457450531411, 4178.477690288714, 4179.352200408942, 4189.874303770892, 5133.512316329943, 5173.8876141629735, 5182.222666600002, 5185.248139019821, 5235.764390602432, 4865.7105866945285, 5038.161071209019, 5150.536451719326, 5203.869903252449, 5208.479152084799, 5462.754176062087, 5473.0, 5483.533899618537, 5483.7806487740445, 5512.228288039678, 4639.605633521155, 4648.1168577970075, 4650.930236046462, 4661.254199328091, 4697.412823397075, 5381.4349493303425, 5530.681591045341, 5540.889182216333, 5636.971815140939, 5773.653580785166, 4613.169629466661, 4691.202495575761, 4731.705123015335, 4763.880902977453, 4785.545373189611, 4819.807207711722, 4827.975860120677, 4845.854624361275, 4852.369192005087, 4861.295112208781, 4831.347768051339, 4840.6127509799135, 5103.545489535464, 5107.795688172431, 5119.6160287978555, 5400.540954018874, 5409.783608655688, 5462.371827239918, 5488.615796894259, 5555.777768889199, 1640.286475383212, 1649.8038921781613, 1663.6672665466956, 1670.0043448079427, 1671.7910261217348, 1263.1978693529675, 1264.886899528409, 1299.811527328532, 1314.5793346129146, 1316.2036967634442, 5370.3287089113865, 5397.7571009304675, 5404.91892621611, 5461.535769459561, 5477.7261136943, 5652.445577466147, 5675.5459563234845, 5684.459976302244, 5684.886302274014, 5689.630174038674, 5277.604179686539, 5374.435684253175, 5377.220303056035, 5424.62027658068, 5477.808276710376, 2917.7519910807396, 2944.4994350960387, 2945.335885224841, 2961.8815247390294, 2969.8663560139844, 5561.805336813273, 5834.854128646818, 5845.006348920694, 5882.3529411764675, 5896.761680047152, 5702.401247868914, 5708.457696518824, 5724.652892314214, 5745.500707192385, 5784.971075144597, 5791.218185544982, 5795.797147099831, 5806.999999999915, 5819.82540523785, 5874.530037597067, 5336.893262134813, 5525.392206857323, 5597.832065037893, 5633.267675202362, 5651.660900345993, 5483.533899618417, 5515.889682206253, 5522.889542209214, 5536.861578460571, 5541.806036788693, 5628.127640215773, 5705.172749951317, 5794.159846822103, 5810.941890581209, 5836.482514546164, 4639.907201855876, 4672.252439609646, 4724.00795832879, 4739.739314337607, 4740.78666460017, 5402.243685884058, 5551.666899986014, 5689.260396148474, 5694.380584930978, 5726.255586773693, 5524.171374293888, 5533.806316778893, 5571.07797809755, 5573.303337082864, 5593.4126916674795, 5493.807716729895, 5521.641093328921, 5533.861653458695, 5556.388797232382, 5594.608377413542, 5366.6779993200535, 5400.62195646301, 5475.589330800286, 5511.614187006871, 5542.3626282977975, 5555.30558680165, 5560.193771903132, 5560.944390556205, 5583.330000399978, 5626.268585084076, 5377.193420986883, 5382.15605954644, 5515.69663668486, 5545.3622833374675, 5565.471280228372], "value": 4455.607590047894, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [856.0668870930684, 886.8226354729056, 923.116841643048, 931.4550987672209, 932.5011119051304, 16813.32746690134, 17015.744763828523, 17134.742978855313, 17311.047892365914, 18906.432807015794, 16804.57988550287, 17011.489655310328, 17188.570285742833, 17560.209790559424, 17715.46853594391, 895.9372843900929, 905.8731777551149, 922.5064590444114, 927.082188633255, 933.5752232734089, 932.0865551759246, 932.8414169591152, 933.621883137327, 934.2385955446324, 935.1817159985013, 978.9363691360039, 979.6375341123794, 980.3382716666257, 980.5342462330407, 980.9754756131083, 976.4629453800381, 977.022977022977, 978.3102912446743, 978.9265805064578, 979.094337737597, 713.7715930902114, 713.989290160648, 714.0895358418059, 714.639107250835, 714.7677004973405, 18134.365297214536, 18150.45548633543, 18495.815041849677, 19133.1390087445, 19321.710174347398, 15067.0, 15582.298796554182, 15705.685886282325, 15846.207689615474, 16115.19424028794, 13124.737505249841, 13300.135491193041, 14146.221957792317, 14550.417983280657, 15537.223138843012, 4922.26166075088, 4948.8762780930765, 4981.9750901245625, 5184.766685499161, 5186.50728180826, 49015.754921225525, 57112.71443642755, 77340.0, 83661.58169209115, 95001.52499237529, 12778.297193654253, 12917.677058073436, 13029.674258143432, 13224.73550528984, 13372.33138343079, 21014.47463813417, 24406.26781196567, 24874.5025099497, 25051.373715657253, 25211.369715757253, 9294.535273236312, 9571.952140239255, 9632.90367096334, 9723.465209413409, 9731.270154738422, 5002.799888004512, 5062.443131255559, 5063.240513922941, 5078.060558796635, 5144.43411224765, 3911.6088391161225, 4013.658838998718, 4013.69897257701, 4017.116234428421, 4019.8995025124023, 691.6783695581579, 703.0298188499837, 705.7247673407376, 707.5860621536356, 710.8258476673249, 660.0528241972688, 691.498663468991, 697.6790676288863, 698.1099098649263, 705.9047028651066, 10849.294795838245, 11349.0, 11528.654140375802, 11578.594749183738, 11727.648170554898, 843.3379796859558, 848.1433751910491, 860.7284000752761, 866.0862789756741, 875.1379890807549, 5523.7790488380015, 5644.92381099735, 5650.576206784508, 5658.122990936411, 5737.540996720252, 72237.27762722305, 85752.14247857567, 86158.56920715356, 87106.56446717726, 89965.55017224872, 76766.23233767702, 77779.61110194413, 79192.60403697945, 79468.20531794724, 79649.0, 51822.74088629533, 54229.45770542244, 57003.714981424826, 65158.88205399799, 65686.34313656898, 12105.75788484243, 12423.192492487959, 12486.218575870103, 12685.746285074063, 12751.298678572768, 43524.34713479237, 43874.12251755011, 45050.0, 45845.31232031455, 46020.30969535393, 50924.490755091974, 51106.0, 51187.488125118274, 51193.488065120364, 52551.47448525466, 13893.166410015432, 13969.93015034959, 14030.508932187324, 14163.221022843842, 14274.0, 16306.429274975319, 16334.509964701077, 16448.424305149263, 16475.0, 17024.23390947435, 15747.527574172793, 15762.527124186292, 15817.604559886095, 15821.841781582498, 16396.180190990162, 15601.063936163866, 15621.0, 15655.530334089995, 15954.122523261332, 16059.27733251983, 15013.699726005638, 15391.307391167647, 15542.844571554591, 15708.68582628364, 15783.131927744083, 10507.15942724565, 10568.313059651098, 10591.841122383325, 10942.835857462303, 11401.429928503707, 12607.558735444216, 12658.556950506689, 12787.424565894744, 12828.358582071045, 12873.549425770054], "value": 8120.91809283557, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1450.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 112.0, 111.0, 111.0, 112.0, 111.0, 111.0, 111.0, 112.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 114.0, 116.0, 152.0, 118.0, 116.0, 115.0, 117.0, 132.0, 116.0], "value": 123.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 162.0, 160.0, 161.0, 159.0, 160.0, 160.0, 159.0, 161.0, 161.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 107.0, 75.0, 77.0, 75.0, 75.0, 95.0, 75.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 107.0, 81.0, 81.0, 82.0, 99.0, 82.0, 83.0, 102.0], "value": 88.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 112.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 93.0, 93.0, 93.0, 94.0, 94.0, 94.0], "value": 93.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 53.0, 54.0, 53.0, 53.0, 54.0, 55.0, 55.0, 53.0, 53.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 53.0, 52.0, 53.0, 52.0, 53.0, 52.0, 53.0, 53.0], "value": 52.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 75.0, 76.0, 75.0, 82.0, 76.0, 76.0, 76.0, 74.0, 75.0], "value": 76.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 121.0, 128.0, 120.0, 120.0, 120.0, 122.0, 139.0, 173.0, 133.0], "value": 130.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 170.0, 158.0, 162.0, 164.0, 161.0, 161.0, 158.0, 162.0, 159.0], "value": 161.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 60.0, 60.0, 60.0, 60.0, 59.0, 62.0, 59.0], "value": 59.7, "unit": "score"}]}]} 04:43:58 INFO - Return code: 0 04:43:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:43:59 INFO - # TBPL SUCCESS # 04:43:59 INFO - Running post-action listener: _resource_record_post_action 04:43:59 INFO - [mozharness: 2017-05-22 11:43:59.005817Z] Finished run-tests step (success) 04:43:59 INFO - Running post-run listener: _resource_record_post_run 04:43:59 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 196608; Write bytes: 326053888; Read time: 236; Write time: 184836 04:43:59 INFO - TinderboxPrint: CPU usage
13.1% 04:43:59 INFO - TinderboxPrint: I/O read bytes / time
196,608 / 236 04:43:59 INFO - TinderboxPrint: I/O write bytes / time
326,053,888 / 184,836 04:43:59 INFO - TinderboxPrint: CPU idle
8,257.9 (86.8%) 04:43:59 INFO - TinderboxPrint: CPU user
1,201.6 (12.6%) 04:43:59 INFO - TinderboxPrint: Swap in / out
0 / 0 04:43:59 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 30658560; Read time: 0; Write time: 10220 04:43:59 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 192512; Write bytes: 262365184; Read time: 68; Write time: 165364 04:43:59 INFO - Running post-run listener: _upload_blobber_files 04:43:59 INFO - Blob upload gear active. 04:43:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:43:59 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:43:59 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', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:43:59 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 Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:44:00 INFO - (blobuploader) - INFO - Open directory for files ... 04:44:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:44:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:44:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:44:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:44:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:44:01 INFO - (blobuploader) - INFO - Done attempting. 04:44:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:44:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:44:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:44:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:44:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:44:02 INFO - (blobuploader) - INFO - Done attempting. 04:44:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:44:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:44:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:44:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:44:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:44:08 INFO - (blobuploader) - INFO - Done attempting. 04:44:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:44:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:44:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:44:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:44:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:44:09 INFO - (blobuploader) - INFO - Done attempting. 04:44:09 INFO - (blobuploader) - INFO - Iteration through files over. 04:44:09 INFO - Return code: 0 04:44:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:44:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:44:09 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/08bc18bc0ef51e4277f4f101b040737e8545c702b7e60b100ae8836dec166efa40fa593c0368a0842423554f9014a3afba9275a12b8dfac8876c88f97bd82ffc", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/db47df9193dbc8853a4efd3cb8cba858974172ad6ef3bf954b43048b0fb473cd0287818c591c2f45af55df6b0e4a03b0bcc61d9cea034cd03ab11bbbac2978ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1da25cf4e1bc424933e2ab0829bf5f03a0255a691f513242e5412ee320ebaa37d85c3787c01afe8d3aacc6dbd503648902584619239ed563bfa4687768882cdb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/efbe338969a2c193a5f9e72ef97402d65aa48fb580d6f3a3d2bb29bdedbbf54290e0d4d5cbea901952293a32b9cf38038bc387d93c44f16bd6d8c7c2ad7d7282"} 04:44:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:44:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:44:09 INFO - Contents: 04:44:09 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/08bc18bc0ef51e4277f4f101b040737e8545c702b7e60b100ae8836dec166efa40fa593c0368a0842423554f9014a3afba9275a12b8dfac8876c88f97bd82ffc", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/db47df9193dbc8853a4efd3cb8cba858974172ad6ef3bf954b43048b0fb473cd0287818c591c2f45af55df6b0e4a03b0bcc61d9cea034cd03ab11bbbac2978ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1da25cf4e1bc424933e2ab0829bf5f03a0255a691f513242e5412ee320ebaa37d85c3787c01afe8d3aacc6dbd503648902584619239ed563bfa4687768882cdb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/efbe338969a2c193a5f9e72ef97402d65aa48fb580d6f3a3d2bb29bdedbbf54290e0d4d5cbea901952293a32b9cf38038bc387d93c44f16bd6d8c7c2ad7d7282"} 04:44:09 INFO - Running post-run listener: copy_logs_to_upload_dir 04:44:09 INFO - Copying logs to upload dir... 04:44:09 INFO - mkdir: /builds/slave/test/build/upload/logs 04:44:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.426229 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-05-22 04:44:09.303738) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-22 04:44:09.307739) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1495448663.425565-1728233154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/08bc18bc0ef51e4277f4f101b040737e8545c702b7e60b100ae8836dec166efa40fa593c0368a0842423554f9014a3afba9275a12b8dfac8876c88f97bd82ffc", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/db47df9193dbc8853a4efd3cb8cba858974172ad6ef3bf954b43048b0fb473cd0287818c591c2f45af55df6b0e4a03b0bcc61d9cea034cd03ab11bbbac2978ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1da25cf4e1bc424933e2ab0829bf5f03a0255a691f513242e5412ee320ebaa37d85c3787c01afe8d3aacc6dbd503648902584619239ed563bfa4687768882cdb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/efbe338969a2c193a5f9e72ef97402d65aa48fb580d6f3a3d2bb29bdedbbf54290e0d4d5cbea901952293a32b9cf38038bc387d93c44f16bd6d8c7c2ad7d7282"} build_url:https://queue.taskcluster.net/v1/task/RRzistD9SHSUBwg1DW3_JQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011295 build_url: 'https://queue.taskcluster.net/v1/task/RRzistD9SHSUBwg1DW3_JQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/08bc18bc0ef51e4277f4f101b040737e8545c702b7e60b100ae8836dec166efa40fa593c0368a0842423554f9014a3afba9275a12b8dfac8876c88f97bd82ffc", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/db47df9193dbc8853a4efd3cb8cba858974172ad6ef3bf954b43048b0fb473cd0287818c591c2f45af55df6b0e4a03b0bcc61d9cea034cd03ab11bbbac2978ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1da25cf4e1bc424933e2ab0829bf5f03a0255a691f513242e5412ee320ebaa37d85c3787c01afe8d3aacc6dbd503648902584619239ed563bfa4687768882cdb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/efbe338969a2c193a5f9e72ef97402d65aa48fb580d6f3a3d2bb29bdedbbf54290e0d4d5cbea901952293a32b9cf38038bc387d93c44f16bd6d8c7c2ad7d7282"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-22 04:44:09.331750) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-22 04:44:09.332060) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1495448663.425565-1728233154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004530 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-22 04:44:09.417059) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-22 04:44:09.417372) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-22 04:44:09.417658) ========= ========= Total master_lag: 0.15 =========