builder: mozilla-beta_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-045 starttime: 1496396088.73 results: success (0) revision: 4f0bd6c5b03dafa6025621da30e1bc87008d027b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-02 02:34:48.727626) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-02 02:34:48.728131) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-02 02:34:48.728448) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-02 02:34:48.754331) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 02:34:48.754659) ========= 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=4300f881736b422476174874000001bc-1496390087.186497-2089198969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-02 02:34:50-- 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% 46.0M=0s 2017-06-02 02:34:50 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.155429 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 02:34:48.947075) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 02:34:48.947413) ========= 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=4300f881736b422476174874000001bc-1496390087.186497-2089198969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013859 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 02:34:49.018384) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-02 02:34:49.021985) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4f0bd6c5b03dafa6025621da30e1bc87008d027b --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 4f0bd6c5b03dafa6025621da30e1bc87008d027b --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=4300f881736b422476174874000001bc-1496390087.186497-2089198969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-02 02:34:50,422 truncating revision to first 12 chars 2017-06-02 02:34:50,422 Setting DEBUG logging. 2017-06-02 02:34:50,422 attempt 1/10 2017-06-02 02:34:50,423 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/4f0bd6c5b03d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-02 02:34:51,720 unpacking tar archive at: mozilla-beta-4f0bd6c5b03d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.600491 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-02 02:34:50.636419) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-02 02:34:50.636726) ========= script_repo_revision: 4f0bd6c5b03dafa6025621da30e1bc87008d027b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-02 02:34:50.640133) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-02 02:34:50.640402) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-02 02:34:50.650416) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-06-02 02:34:50.650699) ========= /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=4300f881736b422476174874000001bc-1496390087.186497-2089198969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:34:52 INFO - MultiFileLogger online at 20170602 02:34:52 in /builds/slave/test 02:34:52 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 02:34:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:34:52 INFO - {'append_to_log': False, 02:34:52 INFO - 'base_work_dir': '/builds/slave/test', 02:34:52 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 02:34:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:34:52 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 02:34:52 INFO - 'buildbot_json_path': 'buildprops.json', 02:34:52 INFO - 'config_files': ('talos/linux_config.py',), 02:34:52 INFO - 'default_actions': ('clobber', 02:34:52 INFO - 'read-buildbot-config', 02:34:52 INFO - 'download-and-extract', 02:34:52 INFO - 'populate-webroot', 02:34:52 INFO - 'create-virtualenv', 02:34:52 INFO - 'install', 02:34:52 INFO - 'run-tests'), 02:34:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:34:52 INFO - 'download_minidump_stackwalk': True, 02:34:52 INFO - 'download_symbols': 'ondemand', 02:34:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:34:52 INFO - 'tooltool.py': '/tools/tooltool.py', 02:34:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:34:52 INFO - '/tools/misc-python/virtualenv.py')}, 02:34:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:34:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:34:52 INFO - 'gecko_profile': False, 02:34:52 INFO - 'gecko_profile_interval': 0, 02:34:52 INFO - 'installer_path': 'installer.exe', 02:34:52 INFO - 'log_level': 'info', 02:34:52 INFO - 'log_name': 'talos', 02:34:52 INFO - 'log_to_console': True, 02:34:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:34:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:34:52 INFO - 'opt_config_files': (), 02:34:52 INFO - 'pip_index': False, 02:34:52 INFO - 'suite': 'dromaeojs', 02:34:52 INFO - 'system_bits': '32', 02:34:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:34:52 INFO - 'title': 'talos-linux64-ix-045', 02:34:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:34:52 INFO - 'use_talos_json': True, 02:34:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:34:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:34:52 INFO - 'work_dir': 'build'} 02:34:52 INFO - [mozharness: 2017-06-02 09:34:52.145963Z] Running clobber step. 02:34:52 INFO - Running pre-action listener: _resource_record_pre_action 02:34:52 INFO - Running main action method: clobber 02:34:52 INFO - rmtree: /builds/slave/test/build 02:34:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:34:53 INFO - Running post-action listener: _resource_record_post_action 02:34:53 INFO - [mozharness: 2017-06-02 09:34:53.689827Z] Finished clobber step (success) 02:34:53 INFO - [mozharness: 2017-06-02 09:34:53.689925Z] Running read-buildbot-config step. 02:34:53 INFO - Running pre-action listener: _resource_record_pre_action 02:34:53 INFO - Running main action method: read_buildbot_config 02:34:53 INFO - Using buildbot properties: 02:34:53 INFO - { 02:34:53 INFO - "project": "", 02:34:53 INFO - "product": "firefox", 02:34:53 INFO - "who": "cbook@mozilla.com", 02:34:53 INFO - "installer_path": "public/build/target.tar.bz2", 02:34:53 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 02:34:53 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta/", 02:34:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs", 02:34:53 INFO - "stage_platform": "linux64", 02:34:53 INFO - "basedir": "/builds/slave/test", 02:34:53 INFO - "buildnumber": 68, 02:34:53 INFO - "platform": "ubuntu64_hw", 02:34:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:34:53 INFO - "slavebuilddir": "test", 02:34:53 INFO - "taskId": "NXyALTk8RO2sgchk2F7RXg", 02:34:53 INFO - "branch": "mozilla-beta", 02:34:53 INFO - "script_repo_revision": "production", 02:34:53 INFO - "revision": "4f0bd6c5b03dafa6025621da30e1bc87008d027b", 02:34:53 INFO - "slavename": "talos-linux64-ix-045", 02:34:53 INFO - "repo_path": "releases/mozilla-beta" 02:34:53 INFO - } 02:34:53 INFO - Finding installer, test and symbols from parent task. 02:34:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NXyALTk8RO2sgchk2F7RXg'}, attempt #1 02:34:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NXyALTk8RO2sgchk2F7RXg'}, attempt #1 02:34:54 INFO - Task dependencies: fBJh4HooTRWQKp_oyHJLMA 02:34:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fBJh4HooTRWQKp_oyHJLMA'}, attempt #1 02:34:55 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/fBJh4HooTRWQKp_oyHJLMA/artifacts/public/build/target.tar.bz2 02:34:55 INFO - Set test_url: https://queue.taskcluster.net/v1/task/fBJh4HooTRWQKp_oyHJLMA/artifacts/public/build/test_packages.json 02:34:55 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/fBJh4HooTRWQKp_oyHJLMA/artifacts/public/build/target.crashreporter-symbols.zip 02:34:55 INFO - Running post-action listener: _resource_record_post_action 02:34:55 INFO - [mozharness: 2017-06-02 09:34:55.019195Z] Finished read-buildbot-config step (success) 02:34:55 INFO - [mozharness: 2017-06-02 09:34:55.019412Z] Running download-and-extract step. 02:34:55 INFO - Running pre-action listener: _resource_record_pre_action 02:34:55 INFO - Running main action method: download_and_extract 02:34:55 INFO - mkdir: /builds/slave/test/build/tests 02:34: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')]} 02:34:55 INFO - trying https://queue.taskcluster.net/v1/task/fBJh4HooTRWQKp_oyHJLMA/artifacts/public/build/target.test_packages.json 02:34:55 INFO - Downloading https://queue.taskcluster.net/v1/task/fBJh4HooTRWQKp_oyHJLMA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:34:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fBJh4HooTRWQKp_oyHJLMA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:34:55 INFO - Downloaded 986 bytes. 02:34:55 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:34:55 INFO - Using the following test package requirements: 02:34:55 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:34:55 INFO - u'common': [u'target.common.tests.zip'], 02:34:55 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:34:55 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:34:55 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:34:55 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:34:55 INFO - u'mozbase': [u'target.common.tests.zip'], 02:34:55 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:34:55 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:34:55 INFO - u'web-platform': [u'target.common.tests.zip', 02:34:55 INFO - u'target.web-platform.tests.zip'], 02:34:55 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:34:55 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:34:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fBJh4HooTRWQKp_oyHJLMA/artifacts/public/build/target.common.tests.zip 02:34:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fBJh4HooTRWQKp_oyHJLMA/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:34:55 INFO - Fetch https://queue.taskcluster.net/v1/task/fBJh4HooTRWQKp_oyHJLMA/artifacts/public/build/target.common.tests.zip into memory 02:34:56 INFO - Expected file size: 59712055 02:34:56 INFO - Obtained file size: 59712055 02:35:06 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:35:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fBJh4HooTRWQKp_oyHJLMA/artifacts/public/build/target.common.tests.zip 02:35:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fBJh4HooTRWQKp_oyHJLMA/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:35:06 INFO - Fetch https://queue.taskcluster.net/v1/task/fBJh4HooTRWQKp_oyHJLMA/artifacts/public/build/target.common.tests.zip into memory 02:35:07 INFO - Expected file size: 59712055 02:35:07 INFO - Obtained file size: 59712055 02:35:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fBJh4HooTRWQKp_oyHJLMA/artifacts/public/build/target.talos.tests.zip 02:35:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fBJh4HooTRWQKp_oyHJLMA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:35:18 INFO - Fetch https://queue.taskcluster.net/v1/task/fBJh4HooTRWQKp_oyHJLMA/artifacts/public/build/target.talos.tests.zip into memory 02:35:18 INFO - Expected file size: 14404461 02:35:18 INFO - Obtained file size: 14404461 02:35:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:35:18 INFO - trying https://queue.taskcluster.net/v1/task/fBJh4HooTRWQKp_oyHJLMA/artifacts/public/build/target.tar.bz2 02:35:18 INFO - Downloading https://queue.taskcluster.net/v1/task/fBJh4HooTRWQKp_oyHJLMA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:35:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fBJh4HooTRWQKp_oyHJLMA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:35:20 INFO - Downloaded 59732444 bytes. 02:35:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fBJh4HooTRWQKp_oyHJLMA/artifacts/public/build/target.tar.bz2 02:35:20 INFO - mkdir: /builds/slave/test/properties 02:35:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:35:20 INFO - Writing to file /builds/slave/test/properties/build_url 02:35:20 INFO - Contents: 02:35:20 INFO - build_url:https://queue.taskcluster.net/v1/task/fBJh4HooTRWQKp_oyHJLMA/artifacts/public/build/target.tar.bz2 02:35:20 INFO - Running post-action listener: _resource_record_post_action 02:35:20 INFO - Running post-action listener: set_extra_try_arguments 02:35:20 INFO - [mozharness: 2017-06-02 09:35:20.097952Z] Finished download-and-extract step (success) 02:35:20 INFO - [mozharness: 2017-06-02 09:35:20.098073Z] Running populate-webroot step. 02:35:20 INFO - Running pre-action listener: _resource_record_pre_action 02:35:20 INFO - Running main action method: populate_webroot 02:35:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:35:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:35:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:35:20 INFO - '--tppagecycles', 02:35:20 INFO - '7'], 02:35:20 INFO - 'tests': ['tsvgm']}}, 02:35:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:35:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:35:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:35:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:35:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:35:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:35:20 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:35:20 INFO - 'talos_options': ['--disable-e10s'], 02:35:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:35:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:35:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:35:20 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:35:20 INFO - 'talos_options': ['--disable-e10s'], 02:35:20 INFO - 'tests': ['damp', 'tps']}, 02:35:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:35:20 INFO - 'tests': ['damp', 'tps']}, 02:35:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:35:20 INFO - 'tests': ['dromaeo_dom']}, 02:35:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:35:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:35:20 INFO - 'tests': ['basic_compositor_video']}, 02:35:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:35:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:35:20 INFO - 'tests': ['a11yr', 02:35:20 INFO - 'ts_paint', 02:35:20 INFO - 'tpaint', 02:35:20 INFO - 'sessionrestore', 02:35:20 INFO - 'sessionrestore_no_auto_restore', 02:35:20 INFO - 'tabpaint']}, 02:35:20 INFO - 'other-e10s': {'tests': ['a11yr', 02:35:20 INFO - 'ts_paint', 02:35:20 INFO - 'tpaint', 02:35:20 INFO - 'sessionrestore', 02:35:20 INFO - 'sessionrestore_no_auto_restore', 02:35:20 INFO - 'tabpaint']}, 02:35:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:35:20 INFO - 'ts_paint', 02:35:20 INFO - 'tpaint', 02:35:20 INFO - 'sessionrestore', 02:35:20 INFO - 'sessionrestore_no_auto_restore', 02:35:20 INFO - 'tabpaint']}, 02:35:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:35:20 INFO - 'ts_paint', 02:35:20 INFO - 'tpaint', 02:35:20 INFO - 'sessionrestore', 02:35:20 INFO - 'sessionrestore_no_auto_restore', 02:35:20 INFO - 'tabpaint']}, 02:35:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:35:20 INFO - 'tests': ['a11yr', 02:35:20 INFO - 'ts_paint', 02:35:20 INFO - 'tpaint', 02:35:20 INFO - 'sessionrestore', 02:35:20 INFO - 'sessionrestore_no_auto_restore', 02:35:20 INFO - 'tabpaint']}, 02:35:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:35:20 INFO - 'tests': ['a11yr', 02:35:20 INFO - 'ts_paint', 02:35:20 INFO - 'tpaint', 02:35:20 INFO - 'sessionrestore', 02:35:20 INFO - 'sessionrestore_no_auto_restore', 02:35:20 INFO - 'tabpaint']}, 02:35:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:35:20 INFO - 'tests': ['tsvgx', 02:35:20 INFO - 'tsvgr_opacity', 02:35:20 INFO - 'tart', 02:35:20 INFO - 'tscrollx', 02:35:20 INFO - 'cart', 02:35:20 INFO - 'tsvg_static']}, 02:35:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:35:20 INFO - 'tsvgr_opacity', 02:35:20 INFO - 'tart', 02:35:20 INFO - 'tscrollx', 02:35:20 INFO - 'cart', 02:35:20 INFO - 'tsvg_static']}, 02:35:20 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:35:20 INFO - 'talos_options': ['--disable-e10s'], 02:35:20 INFO - 'tests': ['tp5o']}, 02:35:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:35:20 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:35:20 INFO - 'talos_options': ['--disable-e10s', 02:35:20 INFO - '--xperf_path', 02:35:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:35:20 INFO - 'tests': ['tp5n']}, 02:35:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:35:20 INFO - 'talos_options': ['--xperf_path', 02:35:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:35:20 INFO - 'tests': ['tp5n']}}, 02:35:20 INFO - 'talos.zip': {'path': '', 02:35:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:35:20 INFO - Running post-action listener: _resource_record_post_action 02:35:20 INFO - [mozharness: 2017-06-02 09:35:20.113149Z] Finished populate-webroot step (success) 02:35:20 INFO - [mozharness: 2017-06-02 09:35:20.113239Z] Running create-virtualenv step. 02:35:20 INFO - Running pre-action listener: _resource_record_pre_action 02:35:20 INFO - Running main action method: create_virtualenv 02:35:20 INFO - Creating virtualenv /builds/slave/test/build/venv 02:35:20 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 02:35:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:35:20 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:35:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:35:20 INFO - Using real prefix '/usr' 02:35:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:35:20 INFO - Installing distribute.............................................................................................................................................................................................done. 02:35:22 INFO - Installing pip.................done. 02:35:22 INFO - Return code: 0 02:35:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:35:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:35:22 INFO - Reading from file tmpfile_stdout 02:35:22 INFO - Output received: 02:35:22 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) 02:35:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:35:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:35:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:22 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 0x22f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258b400>, '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 0x258c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258c840>, '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': '4300f881736b422476174874000001bc-1496390087.186497-2089198969', '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 02:35:22 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 02:35:22 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 02:35:22 INFO - Using env: {'DISPLAY': ':0', 02:35:22 INFO - 'HOME': '/home/cltbld', 02:35:22 INFO - 'LANG': 'en_US.UTF-8', 02:35:22 INFO - 'LANGUAGE': 'en_US:en', 02:35:22 INFO - 'LOGNAME': 'cltbld', 02:35:22 INFO - 'MAIL': '/var/mail/cltbld', 02:35:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:22 INFO - 'MOZ_NO_REMOTE': '1', 02:35:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:35:22 INFO - 'NO_EM_RESTART': '1', 02:35:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:35:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:22 INFO - 'PWD': '/builds/slave/test', 02:35:22 INFO - 'SHELL': '/bin/bash', 02:35:22 INFO - 'SHLVL': '1', 02:35:22 INFO - 'TERM': 'linux', 02:35:22 INFO - 'TMOUT': '86400', 02:35:22 INFO - 'USER': 'cltbld', 02:35:22 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1496390087.186497-2089198969', 02:35:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:22 INFO - '_': '/tools/buildbot/bin/python'} 02:35:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:23 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 02:35:23 INFO - Cleaning up... 02:35:23 INFO - Return code: 0 02:35:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:35:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:35:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:23 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 0x22f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258b400>, '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 0x258c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258c840>, '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': '4300f881736b422476174874000001bc-1496390087.186497-2089198969', '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 02:35:23 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 02:35:23 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 02:35:23 INFO - Using env: {'DISPLAY': ':0', 02:35:23 INFO - 'HOME': '/home/cltbld', 02:35:23 INFO - 'LANG': 'en_US.UTF-8', 02:35:23 INFO - 'LANGUAGE': 'en_US:en', 02:35:23 INFO - 'LOGNAME': 'cltbld', 02:35:23 INFO - 'MAIL': '/var/mail/cltbld', 02:35:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:23 INFO - 'MOZ_NO_REMOTE': '1', 02:35:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:35:23 INFO - 'NO_EM_RESTART': '1', 02:35:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:35:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:23 INFO - 'PWD': '/builds/slave/test', 02:35:23 INFO - 'SHELL': '/bin/bash', 02:35:23 INFO - 'SHLVL': '1', 02:35:23 INFO - 'TERM': 'linux', 02:35:23 INFO - 'TMOUT': '86400', 02:35:23 INFO - 'USER': 'cltbld', 02:35:23 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1496390087.186497-2089198969', 02:35:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:23 INFO - '_': '/tools/buildbot/bin/python'} 02:35:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:23 INFO - Downloading/unpacking psutil>=3.1.1 02:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:35:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:35:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:35:24 INFO - Installing collected packages: psutil 02:35:24 INFO - Running setup.py install for psutil 02:35:24 INFO - building 'psutil._psutil_linux' extension 02:35:24 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 02:35:24 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 02:35:24 INFO - building 'psutil._psutil_posix' extension 02:35:24 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 02:35:24 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 02:35:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:35:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:35:25 INFO - Successfully installed psutil 02:35:25 INFO - Cleaning up... 02:35:25 INFO - Return code: 0 02:35:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:35:25 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')]} 02:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:25 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')]} 02:35:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:25 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 0x22f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258b400>, '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 0x258c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258c840>, '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': '4300f881736b422476174874000001bc-1496390087.186497-2089198969', '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 02:35:25 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 02:35:25 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 02:35:25 INFO - Using env: {'DISPLAY': ':0', 02:35:25 INFO - 'HOME': '/home/cltbld', 02:35:25 INFO - 'LANG': 'en_US.UTF-8', 02:35:25 INFO - 'LANGUAGE': 'en_US:en', 02:35:25 INFO - 'LOGNAME': 'cltbld', 02:35:25 INFO - 'MAIL': '/var/mail/cltbld', 02:35:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:25 INFO - 'MOZ_NO_REMOTE': '1', 02:35:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:35:25 INFO - 'NO_EM_RESTART': '1', 02:35:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:35:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:25 INFO - 'PWD': '/builds/slave/test', 02:35:25 INFO - 'SHELL': '/bin/bash', 02:35:25 INFO - 'SHLVL': '1', 02:35:25 INFO - 'TERM': 'linux', 02:35:25 INFO - 'TMOUT': '86400', 02:35:25 INFO - 'USER': 'cltbld', 02:35:25 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1496390087.186497-2089198969', 02:35:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:25 INFO - '_': '/tools/buildbot/bin/python'} 02:35:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:35:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:35:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:35:26 INFO - Installing collected packages: mozsystemmonitor 02:35:26 INFO - Running setup.py install for mozsystemmonitor 02:35:26 INFO - Successfully installed mozsystemmonitor 02:35:26 INFO - Cleaning up... 02:35:26 INFO - Return code: 0 02:35:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:35:26 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')]} 02:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:26 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')]} 02:35:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:26 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 0x22f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258b400>, '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 0x258c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258c840>, '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': '4300f881736b422476174874000001bc-1496390087.186497-2089198969', '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 02:35:26 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 02:35:26 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 02:35:26 INFO - Using env: {'DISPLAY': ':0', 02:35:26 INFO - 'HOME': '/home/cltbld', 02:35:26 INFO - 'LANG': 'en_US.UTF-8', 02:35:26 INFO - 'LANGUAGE': 'en_US:en', 02:35:26 INFO - 'LOGNAME': 'cltbld', 02:35:26 INFO - 'MAIL': '/var/mail/cltbld', 02:35:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:26 INFO - 'MOZ_NO_REMOTE': '1', 02:35:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:35:26 INFO - 'NO_EM_RESTART': '1', 02:35:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:35:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:26 INFO - 'PWD': '/builds/slave/test', 02:35:26 INFO - 'SHELL': '/bin/bash', 02:35:26 INFO - 'SHLVL': '1', 02:35:26 INFO - 'TERM': 'linux', 02:35:26 INFO - 'TMOUT': '86400', 02:35:26 INFO - 'USER': 'cltbld', 02:35:26 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1496390087.186497-2089198969', 02:35:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:26 INFO - '_': '/tools/buildbot/bin/python'} 02:35:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:26 INFO - Downloading/unpacking jsonschema==2.5.1 02:35:26 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 02:35:26 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 02:35:26 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 02:35:26 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 02:35:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:35:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:28 INFO - Downloading functools32-3.2.3-2.tar.gz 02:35:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:35:28 INFO - warning: no files found matching '*.txt' 02:35:28 INFO - no previously-included directories found matching 'build' 02:35:28 INFO - no previously-included directories found matching 'dist' 02:35:28 INFO - no previously-included directories found matching '.git*' 02:35:28 INFO - Installing collected packages: jsonschema, functools32 02:35:28 INFO - Running setup.py install for functools32 02:35:28 INFO - warning: no files found matching '*.txt' 02:35:28 INFO - no previously-included directories found matching 'build' 02:35:28 INFO - no previously-included directories found matching 'dist' 02:35:28 INFO - no previously-included directories found matching '.git*' 02:35:28 INFO - Successfully installed jsonschema functools32 02:35:28 INFO - Cleaning up... 02:35:28 INFO - Return code: 0 02:35:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:35:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:35:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:35:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x22f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258b400>, '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 0x258c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258c840>, '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': '4300f881736b422476174874000001bc-1496390087.186497-2089198969', '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 02:35:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:35:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:35:28 INFO - Using env: {'DISPLAY': ':0', 02:35:28 INFO - 'HOME': '/home/cltbld', 02:35:28 INFO - 'LANG': 'en_US.UTF-8', 02:35:28 INFO - 'LANGUAGE': 'en_US:en', 02:35:28 INFO - 'LOGNAME': 'cltbld', 02:35:28 INFO - 'MAIL': '/var/mail/cltbld', 02:35:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:28 INFO - 'MOZ_NO_REMOTE': '1', 02:35:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:35:28 INFO - 'NO_EM_RESTART': '1', 02:35:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:35:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:28 INFO - 'PWD': '/builds/slave/test', 02:35:28 INFO - 'SHELL': '/bin/bash', 02:35:28 INFO - 'SHLVL': '1', 02:35:28 INFO - 'TERM': 'linux', 02:35:28 INFO - 'TMOUT': '86400', 02:35:28 INFO - 'USER': 'cltbld', 02:35:28 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1496390087.186497-2089198969', 02:35:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:28 INFO - '_': '/tools/buildbot/bin/python'} 02:35:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:35:28 INFO - Cleaning up... 02:35:28 INFO - Return code: 0 02:35:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:35:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:35:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:35:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x22f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258b400>, '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 0x258c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258c840>, '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': '4300f881736b422476174874000001bc-1496390087.186497-2089198969', '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 02:35:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:35:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:35:28 INFO - Using env: {'DISPLAY': ':0', 02:35:28 INFO - 'HOME': '/home/cltbld', 02:35:28 INFO - 'LANG': 'en_US.UTF-8', 02:35:28 INFO - 'LANGUAGE': 'en_US:en', 02:35:28 INFO - 'LOGNAME': 'cltbld', 02:35:28 INFO - 'MAIL': '/var/mail/cltbld', 02:35:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:28 INFO - 'MOZ_NO_REMOTE': '1', 02:35:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:35:28 INFO - 'NO_EM_RESTART': '1', 02:35:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:35:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:28 INFO - 'PWD': '/builds/slave/test', 02:35:28 INFO - 'SHELL': '/bin/bash', 02:35:28 INFO - 'SHLVL': '1', 02:35:28 INFO - 'TERM': 'linux', 02:35:28 INFO - 'TMOUT': '86400', 02:35:28 INFO - 'USER': 'cltbld', 02:35:28 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1496390087.186497-2089198969', 02:35:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:28 INFO - '_': '/tools/buildbot/bin/python'} 02:35:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:28 INFO - Downloading/unpacking blobuploader==1.2.4 02:35:28 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 02:35:28 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 02:35:28 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 02:35:28 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 02:35:29 INFO - Downloading blobuploader-1.2.4.tar.gz 02:35:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:35:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:35:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:30 INFO - Downloading docopt-0.6.1.tar.gz 02:35:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:35:30 INFO - Installing collected packages: blobuploader, requests, docopt 02:35:30 INFO - Running setup.py install for blobuploader 02:35:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:35:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:35:30 INFO - Running setup.py install for requests 02:35:31 INFO - Running setup.py install for docopt 02:35:31 INFO - Successfully installed blobuploader requests docopt 02:35:31 INFO - Cleaning up... 02:35:31 INFO - Return code: 0 02:35:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:35:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:35:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:31 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 0x22f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258b400>, '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 0x258c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258c840>, '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': '4300f881736b422476174874000001bc-1496390087.186497-2089198969', '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 02:35:31 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 02:35:31 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 02:35:31 INFO - Using env: {'DISPLAY': ':0', 02:35:31 INFO - 'HOME': '/home/cltbld', 02:35:31 INFO - 'LANG': 'en_US.UTF-8', 02:35:31 INFO - 'LANGUAGE': 'en_US:en', 02:35:31 INFO - 'LOGNAME': 'cltbld', 02:35:31 INFO - 'MAIL': '/var/mail/cltbld', 02:35:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:31 INFO - 'MOZ_NO_REMOTE': '1', 02:35:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:35:31 INFO - 'NO_EM_RESTART': '1', 02:35:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:35:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:31 INFO - 'PWD': '/builds/slave/test', 02:35:31 INFO - 'SHELL': '/bin/bash', 02:35:31 INFO - 'SHLVL': '1', 02:35:31 INFO - 'TERM': 'linux', 02:35:31 INFO - 'TMOUT': '86400', 02:35:31 INFO - 'USER': 'cltbld', 02:35:31 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1496390087.186497-2089198969', 02:35:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:31 INFO - '_': '/tools/buildbot/bin/python'} 02:35:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:35:31 INFO - Running setup.py (path:/tmp/pip-5sxyLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:35:31 INFO - Running setup.py (path:/tmp/pip-YGoXtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:35:31 INFO - Running setup.py (path:/tmp/pip-Gl6GFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:35:31 INFO - Running setup.py (path:/tmp/pip-QRUDFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:35:31 INFO - Running setup.py (path:/tmp/pip-wK4hOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:35:31 INFO - Running setup.py (path:/tmp/pip-boi9hT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:35:31 INFO - Running setup.py (path:/tmp/pip-8kikKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:35:31 INFO - Running setup.py (path:/tmp/pip-hagsxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:35:31 INFO - Running setup.py (path:/tmp/pip-83SXfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:35:32 INFO - Running setup.py (path:/tmp/pip-npCkXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:35:32 INFO - Running setup.py (path:/tmp/pip-wo1odI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:35:32 INFO - Running setup.py (path:/tmp/pip-4oyOCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:35:32 INFO - Running setup.py (path:/tmp/pip-JmRIvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:35:32 INFO - Running setup.py (path:/tmp/pip-VSGqtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:35:32 INFO - Running setup.py (path:/tmp/pip-XvBEI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:35:32 INFO - Running setup.py (path:/tmp/pip-CoxWUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:35:32 INFO - Running setup.py (path:/tmp/pip-w86DMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:35:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:35:32 INFO - Running setup.py install for manifestparser 02:35:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:35:32 INFO - Running setup.py install for mozcrash 02:35:32 INFO - Running setup.py install for mozdebug 02:35:32 INFO - Running setup.py install for mozdevice 02:35:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:35:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:35:33 INFO - Running setup.py install for mozfile 02:35:33 INFO - Running setup.py install for mozhttpd 02:35:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:35:33 INFO - Running setup.py install for mozinfo 02:35:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:35:33 INFO - Running setup.py install for mozInstall 02:35:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:35:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:35:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:35:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:35:33 INFO - Running setup.py install for mozleak 02:35:33 INFO - Running setup.py install for mozlog 02:35:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:35:33 INFO - Running setup.py install for moznetwork 02:35:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:35:33 INFO - Running setup.py install for mozprocess 02:35:33 INFO - Running setup.py install for mozprofile 02:35:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:35:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:35:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:35:33 INFO - Running setup.py install for mozrunner 02:35:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:35:34 INFO - Running setup.py install for mozscreenshot 02:35:34 INFO - Running setup.py install for moztest 02:35:34 INFO - Running setup.py install for mozversion 02:35:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:35:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:35:34 INFO - Cleaning up... 02:35:34 INFO - Return code: 0 02:35:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:35:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:35:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:35:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:34 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 0x22f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258b400>, '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 0x258c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258c840>, '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': '4300f881736b422476174874000001bc-1496390087.186497-2089198969', '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 02:35:34 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 02:35:34 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 02:35:34 INFO - Using env: {'DISPLAY': ':0', 02:35:34 INFO - 'HOME': '/home/cltbld', 02:35:34 INFO - 'LANG': 'en_US.UTF-8', 02:35:34 INFO - 'LANGUAGE': 'en_US:en', 02:35:34 INFO - 'LOGNAME': 'cltbld', 02:35:34 INFO - 'MAIL': '/var/mail/cltbld', 02:35:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:34 INFO - 'MOZ_NO_REMOTE': '1', 02:35:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:35:34 INFO - 'NO_EM_RESTART': '1', 02:35:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:35:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:34 INFO - 'PWD': '/builds/slave/test', 02:35:34 INFO - 'SHELL': '/bin/bash', 02:35:34 INFO - 'SHLVL': '1', 02:35:34 INFO - 'TERM': 'linux', 02:35:34 INFO - 'TMOUT': '86400', 02:35:34 INFO - 'USER': 'cltbld', 02:35:34 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1496390087.186497-2089198969', 02:35:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:34 INFO - '_': '/tools/buildbot/bin/python'} 02:35:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:35:34 INFO - Running setup.py (path:/tmp/pip-bT7hmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:35:34 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)) 02:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:35:34 INFO - Running setup.py (path:/tmp/pip-R97NqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:35:34 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)) 02:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:35:34 INFO - Running setup.py (path:/tmp/pip-uVtKbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:35:34 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)) 02:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:35:34 INFO - Running setup.py (path:/tmp/pip-CuZarO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:35:34 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)) 02:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:35:34 INFO - Running setup.py (path:/tmp/pip-tkZxZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:35:35 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)) 02:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:35:35 INFO - Running setup.py (path:/tmp/pip-ZUkspp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:35:35 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)) 02:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:35:35 INFO - Running setup.py (path:/tmp/pip-BDL83p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:35:35 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)) 02:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:35:35 INFO - Running setup.py (path:/tmp/pip-A9WrjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:35:35 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)) 02:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:35:35 INFO - Running setup.py (path:/tmp/pip-Z_1LLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:35:35 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)) 02:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:35:35 INFO - Running setup.py (path:/tmp/pip-SrrEFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:35:35 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)) 02:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:35:35 INFO - Running setup.py (path:/tmp/pip-5dDKpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:35:35 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)) 02:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:35:35 INFO - Running setup.py (path:/tmp/pip-9fP5pE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:35:35 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)) 02:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:35:35 INFO - Running setup.py (path:/tmp/pip-yA_03q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:35:35 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)) 02:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:35:35 INFO - Running setup.py (path:/tmp/pip-TNqLQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:35:35 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)) 02:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:35:35 INFO - Running setup.py (path:/tmp/pip-ICcLI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:35:35 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)) 02:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:35:35 INFO - Running setup.py (path:/tmp/pip-GR2f7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:35:35 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)) 02:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:35:35 INFO - Running setup.py (path:/tmp/pip-vR1bvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:35:35 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)) 02:35:35 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)) 02:35:35 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)) 02:35:35 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)) 02:35:35 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)) 02:35:35 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)) 02:35:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:35:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:36 INFO - Downloading blessings-1.6.tar.gz 02:35:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:35:37 INFO - Installing collected packages: blessings 02:35:37 INFO - Running setup.py install for blessings 02:35:37 INFO - Successfully installed blessings 02:35:37 INFO - Cleaning up... 02:35:37 INFO - Return code: 0 02:35:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:35:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:35:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:35:37 INFO - Reading from file tmpfile_stdout 02:35:37 INFO - Current package versions: 02:35:37 INFO - argparse == 1.2.1 02:35:37 INFO - blessings == 1.6 02:35:37 INFO - blobuploader == 1.2.4 02:35:37 INFO - docopt == 0.6.1 02:35:37 INFO - functools32 == 3.2.3-2 02:35:37 INFO - jsonschema == 2.5.1 02:35:37 INFO - manifestparser == 1.1 02:35:37 INFO - mozInstall == 1.12 02:35:37 INFO - mozcrash == 1.0 02:35:37 INFO - mozdebug == 0.1 02:35:37 INFO - mozdevice == 0.49 02:35:37 INFO - mozfile == 1.2 02:35:37 INFO - mozhttpd == 0.7 02:35:37 INFO - mozinfo == 0.9 02:35:37 INFO - mozleak == 0.1 02:35:37 INFO - mozlog == 3.4 02:35:37 INFO - moznetwork == 0.27 02:35:37 INFO - mozprocess == 0.25 02:35:37 INFO - mozprofile == 0.28 02:35:37 INFO - mozrunner == 6.13 02:35:37 INFO - mozscreenshot == 0.1 02:35:37 INFO - mozsystemmonitor == 0.3 02:35:37 INFO - moztest == 0.8 02:35:37 INFO - mozversion == 1.4 02:35:37 INFO - psutil == 3.1.1 02:35:37 INFO - requests == 1.2.3 02:35:37 INFO - wsgiref == 0.1.2 02:35:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:35:37 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')]} 02:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:37 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')]} 02:35:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:37 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 0x22f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258b400>, '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 0x258c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258c840>, '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': '4300f881736b422476174874000001bc-1496390087.186497-2089198969', '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 02:35:37 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 02:35:37 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 02:35:37 INFO - Using env: {'DISPLAY': ':0', 02:35:37 INFO - 'HOME': '/home/cltbld', 02:35:37 INFO - 'LANG': 'en_US.UTF-8', 02:35:37 INFO - 'LANGUAGE': 'en_US:en', 02:35:37 INFO - 'LOGNAME': 'cltbld', 02:35:37 INFO - 'MAIL': '/var/mail/cltbld', 02:35:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:37 INFO - 'MOZ_NO_REMOTE': '1', 02:35:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:35:37 INFO - 'NO_EM_RESTART': '1', 02:35:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:35:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:37 INFO - 'PWD': '/builds/slave/test', 02:35:37 INFO - 'SHELL': '/bin/bash', 02:35:37 INFO - 'SHLVL': '1', 02:35:37 INFO - 'TERM': 'linux', 02:35:37 INFO - 'TMOUT': '86400', 02:35:37 INFO - 'USER': 'cltbld', 02:35:37 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1496390087.186497-2089198969', 02:35:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:37 INFO - '_': '/tools/buildbot/bin/python'} 02:35:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:37 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)) 02:35:37 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)) 02:35:37 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)) 02:35:37 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)) 02:35:37 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)) 02:35:37 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)) 02:35:37 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)) 02:35:37 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)) 02:35:37 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)) 02:35:37 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)) 02:35:37 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)) 02:35:37 INFO - Cleaning up... 02:35:37 INFO - Return code: 0 02:35:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:35:37 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')]} 02:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:37 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')]} 02:35:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:37 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 0x22f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258b400>, '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 0x258c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258c840>, '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': '4300f881736b422476174874000001bc-1496390087.186497-2089198969', '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 02:35:37 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 02:35:37 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 02:35:37 INFO - Using env: {'DISPLAY': ':0', 02:35:37 INFO - 'HOME': '/home/cltbld', 02:35:37 INFO - 'LANG': 'en_US.UTF-8', 02:35:37 INFO - 'LANGUAGE': 'en_US:en', 02:35:37 INFO - 'LOGNAME': 'cltbld', 02:35:37 INFO - 'MAIL': '/var/mail/cltbld', 02:35:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:37 INFO - 'MOZ_NO_REMOTE': '1', 02:35:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:35:37 INFO - 'NO_EM_RESTART': '1', 02:35:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:35:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:37 INFO - 'PWD': '/builds/slave/test', 02:35:37 INFO - 'SHELL': '/bin/bash', 02:35:37 INFO - 'SHLVL': '1', 02:35:37 INFO - 'TERM': 'linux', 02:35:37 INFO - 'TMOUT': '86400', 02:35:37 INFO - 'USER': 'cltbld', 02:35:37 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1496390087.186497-2089198969', 02:35:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:37 INFO - '_': '/tools/buildbot/bin/python'} 02:35:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:35:37 INFO - Cleaning up... 02:35:37 INFO - Return code: 0 02:35:37 INFO - Running post-action listener: _resource_record_post_action 02:35:37 INFO - Running post-action listener: _start_resource_monitoring 02:35:37 INFO - Starting resource monitoring. 02:35:37 INFO - [mozharness: 2017-06-02 09:35:37.900355Z] Finished create-virtualenv step (success) 02:35:37 INFO - [mozharness: 2017-06-02 09:35:37.900825Z] Running install step. 02:35:37 INFO - Running pre-action listener: _resource_record_pre_action 02:35:37 INFO - Running main action method: install 02:35:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:35:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:35:38 INFO - Reading from file tmpfile_stdout 02:35:38 INFO - Detecting whether we're running mozinstall >=1.0... 02:35:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:35:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:35:38 INFO - Reading from file tmpfile_stdout 02:35:38 INFO - Output received: 02:35:38 INFO - Usage: mozinstall [options] installer 02:35:38 INFO - Options: 02:35:38 INFO - -h, --help show this help message and exit 02:35:38 INFO - -d DEST, --destination=DEST 02:35:38 INFO - Directory to install application into. [default: 02:35:38 INFO - "/builds/slave/test"] 02:35:38 INFO - --app=APP Application being installed. [default: firefox] 02:35:38 INFO - mkdir: /builds/slave/test/build/application 02:35:38 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'] 02:35:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:35:52 INFO - Reading from file tmpfile_stdout 02:35:52 INFO - Output received: 02:35:52 INFO - /builds/slave/test/build/application/firefox/firefox 02:35:52 INFO - Running post-action listener: _resource_record_post_action 02:35:52 INFO - [mozharness: 2017-06-02 09:35:52.779746Z] Finished install step (success) 02:35:52 INFO - [mozharness: 2017-06-02 09:35:52.779988Z] Running run-tests step. 02:35:52 INFO - Running pre-action listener: _resource_record_pre_action 02:35:52 INFO - Running main action method: run_tests 02:35:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:35:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:35:52 INFO - Python 2.7.3 02:35:52 INFO - Return code: 0 02:35:52 INFO - grabbing minidump binary from tooltool 02:35: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')]} 02:35:52 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 0x258b400>, '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 0x258c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258c840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:35:52 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 02:35:52 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 02:35:52 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 02:35:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:35:52 INFO - Return code: 0 02:35:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:35:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:35:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:35:52 INFO - ENV: RUST_BACKTRACE is now 1 02:35:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:35:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:35:52 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/fBJh4HooTRWQKp_oyHJLMA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 02:35:52 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/fBJh4HooTRWQKp_oyHJLMA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 02:35:52 INFO - Using env: {'DISPLAY': ':0', 02:35:52 INFO - 'HOME': '/home/cltbld', 02:35:52 INFO - 'LANG': 'en_US.UTF-8', 02:35:52 INFO - 'LANGUAGE': 'en_US:en', 02:35:52 INFO - 'LOGNAME': 'cltbld', 02:35:52 INFO - 'MAIL': '/var/mail/cltbld', 02:35:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:35:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:35:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:52 INFO - 'MOZ_NO_REMOTE': '1', 02:35:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:35:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:35:52 INFO - 'NO_EM_RESTART': '1', 02:35:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:35:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:52 INFO - 'PWD': '/builds/slave/test', 02:35:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:35:52 INFO - 'RUST_BACKTRACE': '1', 02:35:52 INFO - 'SHELL': '/bin/bash', 02:35:52 INFO - 'SHLVL': '1', 02:35:52 INFO - 'TERM': 'linux', 02:35:52 INFO - 'TMOUT': '86400', 02:35:52 INFO - 'USER': 'cltbld', 02:35:52 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1496390087.186497-2089198969', 02:35:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:52 INFO - '_': '/tools/buildbot/bin/python'} 02:35:52 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/fBJh4HooTRWQKp_oyHJLMA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 02:35:53 INFO - mozversion application_buildid: 20170602083216 02:35:53 INFO - mozversion application_changeset: 4f0bd6c5b03dafa6025621da30e1bc87008d027b 02:35:53 INFO - mozversion application_display_name: Firefox 02:35:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:35:53 INFO - mozversion application_name: Firefox 02:35:53 INFO - mozversion application_remotingname: firefox 02:35:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 02:35:53 INFO - mozversion application_vendor: Mozilla 02:35:53 INFO - mozversion application_version: 54.0 02:35:53 INFO - mozversion platform_buildid: 20170602083216 02:35:53 INFO - mozversion platform_changeset: 4f0bd6c5b03dafa6025621da30e1bc87008d027b 02:35:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 02:35:53 INFO - mozversion platform_version: 54.0 02:35:53 INFO - using testdate: 1496396153 02:35:53 INFO - actual date: 1496396153 02:35:53 INFO - starting webserver on 'localhost:60748' 02:35:53 INFO - SUITE-START | Running 2 tests 02:35:53 INFO - TEST-START | dromaeo_css 02:35:53 INFO - operating with platform_type : linux_ 02:35:53 INFO - Initialising browser for dromaeo_css test... 02:35:53 INFO - TEST-INFO | started process 21261 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm6LK53/profile http://localhost:60748/getInfo.html) 02:35:57 INFO - PROCESS | 21261 | __metrics Screen width/height:1600/1200 02:35:57 INFO - PROCESS | 21261 | colorDepth:24 02:35:57 INFO - PROCESS | 21261 | Browser inner width/height: 1024/697 02:35:57 INFO - PROCESS | 21261 | __metrics 02:35:58 INFO - PROCESS | 21261 | 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" 02:35:58 INFO - PROCESS | 21261 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:35:58 INFO - PROCESS | 21261 | console.error: PushService: 02:35:58 INFO - PROCESS | 21261 | stateChangeProcessEnqueue: Error transitioning state 02:35:58 INFO - PROCESS | 21261 | UnknownError 02:35:59 INFO - TEST-INFO | 21261: exit 0 02:35:59 INFO - Browser initialized. 02:35:59 INFO - Running cycle 1/1 for dromaeo_css test... 02:35:59 INFO - TEST-INFO | started process 21355 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm6LK53/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:36:11 INFO - PROCESS | 21355 | RSS: Main: 141516800 02:36:11 INFO - PROCESS | 21355 | 02:39:12 INFO - PROCESS | 21355 | Cycle 1(1): loaded http://localhost:60748/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60748/tests/dromaeo/cssquery-ext.html) 02:39:13 INFO - PROCESS | 21355 | RSS: Main: 267501568 02:39:13 INFO - PROCESS | 21355 | 02:42:16 INFO - PROCESS | 21355 | Cycle 1(1): loaded http://localhost:60748/tests/dromaeo/cssquery-ext.html (next: http://localhost:60748/tests/dromaeo/cssquery-jquery.html) 02:42:16 INFO - PROCESS | 21355 | RSS: Main: 231403520 02:42:16 INFO - PROCESS | 21355 | 02:45:18 INFO - PROCESS | 21355 | Cycle 1(1): loaded http://localhost:60748/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60748/tests/dromaeo/cssquery-mootools.html) 02:45:19 INFO - PROCESS | 21355 | RSS: Main: 177037312 02:45:19 INFO - PROCESS | 21355 | 02:48:21 INFO - PROCESS | 21355 | Cycle 1(1): loaded http://localhost:60748/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60748/tests/dromaeo/cssquery-prototype.html) 02:48:21 INFO - PROCESS | 21355 | RSS: Main: 173838336 02:48:21 INFO - PROCESS | 21355 | 02:51:24 INFO - PROCESS | 21355 | Cycle 1(1): loaded http://localhost:60748/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60748/tests/dromaeo/cssquery-yui.html) 02:51:24 INFO - PROCESS | 21355 | RSS: Main: 172765184 02:51:24 INFO - PROCESS | 21355 | 02:54:27 INFO - PROCESS | 21355 | Cycle 1(1): loaded http://localhost:60748/tests/dromaeo/cssquery-yui.html (next: http://localhost:60748/tests/dromaeo/cssquery-dojo.html) 02:54:27 INFO - PROCESS | 21355 | RSS: Main: 254156800 02:54:27 INFO - PROCESS | 21355 | 02:54:27 INFO - PROCESS | 21355 | __start_tp_report 02:54:27 INFO - PROCESS | 21355 | _x_x_mozilla_page_load 02:54:27 INFO - PROCESS | 21355 | _x_x_mozilla_page_load_details 02:54:27 INFO - PROCESS | 21355 | |i|pagename|runs| 02:54:27 INFO - PROCESS | 21355 | |0;dojo.html;3367;3369.494575813626;3404.200012996946;3407.2333724911914;3457.4640930655755;5641.492265696086;5706.115552089433;5718.771249150034;5721.113227449752;5724.685142317171;5652.773889044443;5684.062129748587;5726.942730572693;5734.512566431858;5754.16564598133;5194.27280180775;5196.142636464988;5211.062008838408;5244.239585260135;5273.314469119009;5081.034603425356;5100.387953445573;5281.70950597717;5293.311869456965;5320.813771517997;5194.039102765982;5200.791968321262;5220.947790522084;5232.215167724853;5240.318758561381;5290.92063619046;5292.020976119411;5301.098813201726;5302.3902251241025;5303.443138470482;5016.44819069902;5149.639525233235;5213.165893457067;5262.894742105174;5272.393674727417;5570.721463926788;5577.3028371453565;5679.375268720438;5690.260266165414;5691.089425691911;6132.816015519497;6173.32093469718;6173.660448675321;6181.845453863644;6181.845453863644;6196.845078873019;6197.225346831646;6201.317855035943;6213.627182369072;6214.5960512566535;5587.55299576037;5625.578081643852;5725.856853578611;5727.4845263926445;5731.140328950607;6261.841559311542;6265.937340626535;6267.310595834455;6267.65527895961;6294.716737746812;6028.186194863637;6074.453299203093;6074.848128796815;6084.787032453932;6085.5435842312;5920.940790592125;5945.10823376497;6009.729562169713;6093.086037094471;6164.229471316085;6109.14471973924;6109.28320792043;6112.266528016667;6120.051392034242;6123.08153776937;5839.474447299764;5844.766209351578;5849.034909240013;5905.40945905406;6110.832160914;4562.954370456253;4639.141758774637;4645.767711614406;4646.233371493666;4647.512011238839;4163.770992595376;4167.74993500391;4168.895777605584;4176.749395036308;4193.874183774492;5808.128780682847;5829.970850145722;5838.153467747153;5844.94155058444;5847.473727364558;6100.115483254903;6105.84735381619;6112.877742445126;6113.083037544404;6121.47967422774;5643.661380317194;5695.231143795535;5764.913526297109;5789.218455508537;5846.532277417797;5225.555827754607;5232.607554433433;5232.659877107976;5233.267342572043;5257.263983042377;6318.0838778375955;6326.367363263729;6366.84082897922;6379.744810207632;6385.425311721968;5950.107483877453;5994.400559943971;6005.3694362091355;6008.098785182257;6010.128531363015;6257.843553911189;6260.467860231931;6261.092141639528;6264.248290205022;6314.936850631435;6074.7266373012435;6084.60450070744;6108.205933228652;6116.694165291807;6124.38756124384;6132.478739307209;6171.783987560414;6182.814515564541;6183.041628547582;6184.288806787097;5809.883802324014;6007.189029480965;6008.068749343859;6013.218281623536;6013.548983826143;5899.292084949833;5942.73257703413;5945.672987985702;5970.432808883149;5983.132445795248;5975.611585247119;5989.071693887455;5995.190649262294;5997.520198384206;6003.909941350796;5791.362950075572;6031.5476339273855;6042.577019608585;6055.939440605714;6060.212172417558;5763.682997435181;5847.912281315868;5869.06095024811;5905.320888097924;5905.498032667099 02:54:27 INFO - PROCESS | 21355 | |1;ext.html;746.9439792015601;806.6773290683726;826.4132465949174;880.0891077734547;893.3746377535726;31723;43887.12225755483;44563.554364456344;44678.776606116924;44754.999999999956;47578.762106189504;47750;47752.76123619386;47804;47881.521184788144;6833;6961.617111058889;9314.580843862042;9453.291003174754;9459.10138536838;10823.350598964047;11078.723031924226;11099.889001109967;11102.2783519071;11551.018163456116;11234.775304493905;11292.322460652345;11293.830592541119;11295.661130166067;11300.15248856335;11196.384198869058;11199.60801371948;11226.943865280662;11239;11248.38133902635;10865.674029779118;10897.073748731367;10918.945405273002;10920.12638988879;10923.945380273048;43168;43359.78320108411;43407.56592434067;43419.565804341866;43467.565324346986;4363.80362883671;4378.580323785804;4399.3840862278985;4487.618552423048;4529.297958816356;30623.693763062307;31602.841985789924;31821.84089079563;32028;32689;4355.107203023373;4391.341298805173;4449.866504004885;4529.796159172845;4544.341070544752;229163;231614.84192579097;231797;231931;233572;55126;55153.72423137858;55326.72336638291;55363.72318138384;55483.445165547826;57413;57504.42495575074;57704.711476442346;57776.71111644499;57843.42156578381;16403.179841007903;16499.422520211734;16530.173491325626;16550.089745063895;16564.917175414044;12521.186122901981;12769.425375858109;14285.214313212873;14638.926805365905;14641.707165856624;13931.58205253844;14089.084209526349;14157.787633185511;14205.218712970885;14209;5351.464853514695;5391.9460805391445;5456.345238571397;5520.3651580068;5587.525060369914;1003.3127307794184;1007.3955626623967;1013.6401577439902;1014.9644762433279;1020.6733845169474;29067.56398654022;29099.85450072736;29124.048525214315;29282.853585731937;29386.11841644754;1070.5236169904474;1094.0645747885603;1097.5884043483693;1098.9340639561651;1102.311055590256;14589.343479543233;15234.695306093816;15442.227888605525;15534.611634708997;15802.525924222291;314893;315492;316289;316364;316447;57970;58121;58170;58171.4182858166;58221.70889145527;1466.34747537347;1479.2234077109388;1507.773833924898;1537.7102766483263;1545.0420739141805;25855.870720646275;28860.278493037003;29299.41401171922;29468.410631787672;29912.401751964404;41293.38059929164;41509.79245103755;41524;41564.3765343514;41795.37306940337;268012;268965;270290;271109.15563377243;271577;27960;28774.280642983256;30770.692293076783;31707.207319816265;34565.48151777776;35523;36758.44862327014;45219.32171017372;45813;45833.312500311855;31861;32370.190745231557;32495.675043249266;32669.509957350183;32876.86300390467;31913.68086319107;32080.35839283248;32088.074715517145;32159.67840321567;32637.18407039843;35157.82421087878;35284.64715352814;35308.47037294391;35310.11724706903;35749.64250357463;30672.233194169432;30791.69208307978;31225.8438707805;31264.374712506076;31641.050768476063;24376.390590234678;25223;25422;25718.614220787076;25785.484290314464 02:54:27 INFO - PROCESS | 21355 | |2;jquery.html;429.14599946107256;451.1023064102437;455.8153947651201;460.0637702275867;475.9809607615696;18253.269869205233;19973.700394494077;20374.388768336972;20457.693134602956;22254.109835606578;20968.217701495352;23147.30558083256;23209.883950580264;23256.302310930656;23472.64791028136;6618.106555614979;6625.668716564177;6897.931020689804;6904.723811047552;6919.6540172991145;6640.634765087918;6647.135872336614;6705.597664140143;6706.731730730765;6754.257031726506;6631.568948018387;6672.299408562079;6674.6662666866705;6675.098861653688;6728.158980127484;6576.4410025147445;6708;6757.560758550679;6770.1537307836525;6772.322767723213;6589.571677840925;6621.602703837737;6625.238097618787;6628.5691430056895;6636.93363066368;25165.24504264875;25388.873055634787;25405.872970635028;25426;25904.352391190183;3017.2456885778556;3111.48660471022;3128.765342599291;3131.373725254958;3187.585613870182;16790.83209167917;16881.915590422093;16952.660946780994;16968.151592420454;17103.401380951607;2238.250186187629;2264.615015447378;2277.464795772992;2335.381124002141;2347.260612906929;98854.50572747162;99227;99511.50244248733;100006.4999674997;101317;18158.365747082826;18225.544361391072;18355.81644183568;18425.907870460564;18606.44180674582;32831;32839;32853.67146328554;32916.67083329184;33063.17342066467;10734.463276836126;10801.729956751144;10866.836997445045;10876.673699789018;10920.12638988879;9118.81762364749;9181.219596334386;9197.310201734897;9405.482698451651;9467.715968520955;9308.44149351041;9336.299777516577;9461;9708.689326940914;9722.867781192965;3769.566499852497;3770.8868733938025;3774.5281839770028;3843.9807800961376;3919.196564704229;969.8496733006396;973.454865275448;976.5263847034183;982.651158838602;987.6148302162162;20019.499512512302;21568.892155539437;22243.888780555993;22449.551008979728;22560.210392636178;1093.371311495893;1101.3777215873006;1102.090775110537;1124.656979621207;1141.3919194640207;11333.263337883176;11355.432228388712;11479.253848499988;11533.942330288295;11734.530618775154;652854;656875;667279;670628;671775;110223;114409.14462773062;119565;120808.39595801965;122399;1337.518493342396;1409.8519655436237;1411.068694661498;1412.3785534364847;1425.5509514502899;18591.90704046471;19084.141213645697;19281.035948202814;19285;19531.60936781228;45849;47087.76456117698;47829;50214.748926256594;50321.496785033145;67634.3236567628;67768;68327;69959.65020174866;70359;12614.810777838524;13111.409986550438;13354.799678004643;13358.86641133615;13487.123336983064;14761;14956.925215373854;15142.772858406912;15164.772528412303;15464.072155670696;12715.300658463873;12815.807762883751;12822.487100516248;13097.148685335424;13104.606861794162;11576.94211528937;11681.707957301136;12111.697207569881;12137.211081280042;12340.753184936431;12451.439685214005;12713.42789574453;12821.743565128458;13032.609021729364;13082.411291492095;12804;13013.284269365276;13092.738145237232;13095.279759613313;13365;12339.444724987578;12549.498020079094;12629.431675574804;12939.094263401848;12951.222926624432 02:54:27 INFO - PROCESS | 21355 | |3;mootools.html;1408.0284603623493;1551.868091212247;1574.1420925595553;1587.5237428771366;1589.237166160243;9141.497217653026;10415.375077495355;10724.195685323612;10748;10748.570057197723;10858.782824343529;10903.073238774694;10905;10921.726956826084;10925;1950.882947023176;2020.7777144514166;2383.797377222934;2409.5301416223842;2410.650455683925;2363.1492662641435;2414.8309618326725;2424.212131057405;2427.0413186791206;2432.70807503099;2392.055138220402;2392.7726865947707;2406.590879550472;2408.3377071305445;2419.5281920025514;2376.6910301660846;2391.880405979694;2394.6767186429784;2399.568077746005;2400.7719266669637;2298.092253559851;2320.0951628864755;2357.03361621736;2359.2214569192124;2363.9527209455887;11142.387168705718;11197.048250898684;11203.103751699844;11203.495842687098;11219.214654974156;5688.914666280009;5808.738606762664;5830.562707796932;5852.063669812809;5860.97069514654;3339.1819004344093;3474.4614584739406;3661.9450708239397;3673.7061035117395;3697;1335.1588499245413;1336.3518693433678;1345.219772531929;1419.8367187773435;1434.7202295552372;16107.838921610752;16115.83884161155;16132.516024519284;16160.353585856552;16160.75758863618;4655.231886738718;4717.811287548459;4733.905321893543;4777.546133117348;4795.088933102699;13605;13609.795853062213;13633;13634.181949083088;13637;5811.15738217956;5835.124731290341;5874.353821079678;5914.260717410324;5916.290045194604;5186.066508028591;5267.209918512177;5304.761285742151;5313.256144139824;5415.160650099241;4043.6370865535387;4140.627343539096;4160.791960401968;4167.437395951569;4178.394132850781;1109.3011402816173;1110.2006555280186;1126.5493802479075;1128.1989787251143;1134.9148813838995;1070.6948519671855;1086.2450596835124;1087.3095584303867;1088.8693356797078;1092.9672109836717;7050.823729406703;7110.893336599956;7135.215126336099;7172.713091476387;7188.317109874553;1066.893310668927;1073.9194560408;1116.436199719153;1153.5385845661801;1158.3050169897995;4522.841700540465;4758.07217592573;4798.160321943646;4806.567408933212;4823.155947709137;13735.656608584864;13871.861281387259;14075;14273.928630356782;14311.069780464237;13956.371963261678;14158.221297828719;14191.716165676835;14264;14363.425462981573;9630.614775408905;9885.75285617851;10374.22193335503;10536.578536858593;10543.209259305582;7120.537165084253;7213.350798428167;7271.3455788979245;7358.264173582599;7431.851362972819;12358.44387002605;12467.625971220878;12535.373231338579;12931;13076.215427074407;12460.501579936701;12616.621501354974;12723.23660580368;12734.745305094031;12969.286689232184;9421.340506164503;9525.57134928916;9563.665271715456;9611.327207095435;9658.855117173107;10347.63783267582;10404.167666586807;10478.633247836595;10486.79026419452;10505.474726263808;8726.563671816257;8743.081976392641;8764.91235087641;8860.601272942862;8918.598663060047;8459.534725590152;8663.95668021656;8681.609327580149;8808.647654093764;8958.507282099547;8262.917370826215;8284.46151000183;8428.4942903426;8442.577871106543;8481.15188481147;6191.473724733448;6306.810795676137;6320.336364681642;6339.809805705836;6621.536492445675;6410.1987251593555;6508.674566271762;6543.1821022372205;6570.08018877348;6663.433608143362 02:54:27 INFO - PROCESS | 21355 | |4;prototype.html;414.75454568005364;421.191312679655;421.58684489200584;425.3598334506567;431.38527598172595;5266.631335806495;5279.524842764155;5319.867003324919;5375.596830237733;5388.595855310853;5203.557697595709;5207.583393328534;5227.3465816772905;5227.79088836446;5260.210968354749;4448.466184057917;4481.529439408864;4564.292534657116;4569.565891240343;4621.58405743483;4566.680332376735;4609.819224734939;4620.584147426731;4637.768111594423;4644.373009643706;4476.843310484133;4620.584147426731;4638.744869032219;4639.327297541854;4670.206064968964;4378.233809083397;4524.932126018112;4534.36518887356;4578.725276483388;4580.770961451947;4393.890152746207;4404.933925991113;4421.977890110529;4431.800568974404;4445.844395446144;5164.509371609729;5172.353455818023;5178.223266510016;5181.600967738727;5225.066725311621;5133.358330208724;5254.185601231815;5269;5321.2284218788445;5361.571074314045;5529.815722789475;5537.446255374431;5561.193626924114;5562.137868630329;5606.6636001839615;4869.902601947977;4890.948446084109;4909.533594308535;4916.50834916509;4933.753312334369;5475.753591088411;5558.303728020902;5622.606417550773;5817.941820581782;5830.47525722687;4920.581750551171;4987.775550100254;5019.196928491424;5066.771995260222;5080.59355251579;5174.456682048406;5175.637705360588;5190.169572868398;5198.298229739013;5207.7916883325;5117.669405954479;5179.507946745053;5199.400299850075;5251.947480525222;5284.7052472143805;5496.340439147248;5505.752241149158;5509.201165830932;5539.972300138554;5548.528375088163;1772.1847949943171;1772.7252275897256;1781.6703909776734;1790.543411430103;1802.504311314373;1452.8619781120776;1457.0019536617451;1467.8770740383616;1476.372541669786;1505.473084420466;5365.973170134124;5387.973060134675;5394.271773310631;5404.540614047772;5432.592555558349;5351.919721204107;5608.719564021782;5659.462351076641;5672.461116193955;5708.629928817054;5286.788528458896;5309.628326017219;5355.544778693855;5408.702521361363;5413.377461591888;2946.955795663067;2957.816873250717;2982.910512684623;2983.895563655262;2985.5223164293607;5572.554195664337;5814.738336774855;5820.30156381237;5870.706464676835;5885.555860828802;5711.001149597608;5729.427057294321;5730.656160630376;5734.827955161351;5745.3105627324985;5859.414058594107;5865.706714664249;5892.381299963527;5919.911201331984;5920.911186332209;5383.515483606494;5666.206731057738;5677.489025987681;5681.829545113653;5686.839001179525;5336.359636843604;5546.75039623226;5626.943730562642;5630.605857590093;5644.88710225785;5477.178423236546;5613.382527921844;5641.633293835887;5692.516136128475;5851.941480585139;4689.546240665405;4713.528647135259;4739.312799644102;4756.382829837872;4771.188897887437;5542.2795036644975;5618.297712785902;5630.690312032878;5700.942990570041;5729.140628905698;5494.642848214853;5498.202760599611;5525.960721603183;5555.083496193806;5580.600341853042;5479.383581843445;5515.889682206413;5516.862078448071;5530.861728456821;5561.943230786138;5347.224652425454;5443.080981693174;5491.725413729378;5495.587830912617;5522.779088836563;5529.419410961791;5536.972315138399;5538.44615538459;5541;5543.833684989457;5220.843374698765;5416.620836541404;5419.376771671151;5433.56531477473;5433.809816656398 02:54:27 INFO - PROCESS | 21355 | |5;yui.html;877.9868301975472;878.912108789121;884.1953822021961;890.6481939633849;918.8543561328822;16708.832911670896;18318.35885743999;18322.267109315646;18364.724529132072;18384;16355.91822040891;16845.494635160932;16995.83004169958;17006.744898826528;17008.06455644939;702.0627462337785;713.6182142553735;887.2502735188755;889.7375274294099;902.0843843498853;909.5906841921129;911.9863202051974;912.7079334612927;914.6570036236411;915.7344370132654;958.4776296918161;963;963.4941655630815;964.4599024546242;965.0590674092773;958.8034452937131;958.9520523973808;959.040959040959;960.3085778239691;960.7886265021684;704.2183176673888;704.4012589299106;705.340506626306;705.7318219076769;706.1773034414952;17183.742243866353;17215.913920430445;17377.826221737872;17923.462296131136;18136.727949080774;17145.485635430956;17202.82797172025;17449;17521.561960950952;17811.287548498043;13375.866241337559;13521.577250805789;13639.454421823115;13775.448982040707;13838.100523465942;4142.46148000761;4154.813033413473;4225.9788701056605;4294.098239369736;4358.869233922956;66160;66987.33012669909;77767.22232777656;88155;89435.55282223548;13905;13931.303434828218;13987;14006.299685015912;14078.788818167735;26201.21396358112;26313.868430657723;26383.208503744918;26465.338366540604;26478.205653830417;9553.283503737248;9583;9756.707298781048;9772.267079969031;9829.557669904729;5155.149400348901;5176.430592634807;5203.349581302337;5308.973455132699;5336.146216605324;3907.765534067965;3992.6207010333974;4013.799310034545;4015.277250095011;4022.738521996061;625.340266019354;630.3538872655565;641.0992555459587;651.7034749189107;658.9505787065989;850.8170743290223;866.3675516872593;873.3580818098692;874.3267683883374;881.259741816877;11686.94156529212;11713.414329283502;11822.52709891612;11963.222390544586;12232.938835305944;819.3117781063935;845.526505157114;853.8206976534997;865.7056600755773;874.2699845628971;5508.889822203533;5545.140503222007;5613.803516876889;5679.574031947621;5718.399568045378;77760;78220.60889695628;78753.60623196847;79805;83205.58397207975;71363.64318178376;72051;73298;74581;75143.62428187934;65199.67400162969;65442.345576544576;66055.33944660588;66644;67038;10738.46307684597;10952.288101273392;11103.833442498208;11244.212905096565;11278;45501.31748023716;46314.53685463102;46543;46798.76600616975;46838;52457.21314180214;52598.21102683539;52969;53091;54328.46864953765;13801.447942082204;13969.231692257023;14068.507602233873;14113.2943352834;14197.858021420067;14354.210518421587;14498.34757435939;14835.925820371262;15102.697946041237;15489.225538723244;13425.66435839112;13867.583972480841;13875.653108672364;13933;14150.78773818373;10344.586216551254;14018.929905350817;14036.157830530201;14126.717465650423;14220.146791192561;13860.722785544434;14187.716245674823;14339.426422943383;14396.424143034581;14506.492272770402;11359.943200283946;11413.942930285295;11537.134714896249;11701.2979221247;12018.639440816789;12174.33041182708;12221.69445763863;12327.93836030814;12537.185082969578;12927.935360323138 02:54:27 INFO - PROCESS | 21355 | __end_tp_report 02:54:27 INFO - PROCESS | 21355 | __start_cc_report 02:54:27 INFO - PROCESS | 21355 | _x_x_mozilla_cycle_collect,1267 02:54:27 INFO - PROCESS | 21355 | __end_cc_report 02:54:27 INFO - PROCESS | 21355 | __startTimestamp1496397267696__endTimestamp 02:54:27 INFO - PROCESS | 21355 | 02:54:27 INFO - PROCESS | 21355 | ------- Summary: start ------- 02:54:27 INFO - PROCESS | 21355 | Number of tests: 6 02:54:27 INFO - PROCESS | 21355 | 02:54:27 INFO - PROCESS | 21355 | [#0] dojo.html Cycles:165 Average:5679.66 Median:5869.06 stddev:633.87 (10.8%) stddev-sans-first:609.29 02:54:27 INFO - PROCESS | 21355 | Values: 3367.0 3369.5 3404.2 3407.2 3457.5 5641.5 5706.1 5718.8 5721.1 5724.7 5652.8 5684.1 5726.9 5734.5 5754.2 5194.3 5196.1 5211.1 5244.2 5273.3 5081.0 5100.4 5281.7 5293.3 5320.8 5194.0 5200.8 5220.9 5232.2 5240.3 5290.9 5292.0 5301.1 5302.4 5303.4 5016.4 5149.6 5213.2 5262.9 5272.4 5570.7 5577.3 5679.4 5690.3 5691.1 6132.8 6173.3 6173.7 6181.8 6181.8 6196.8 6197.2 6201.3 6213.6 6214.6 5587.6 5625.6 5725.9 5727.5 5731.1 6261.8 6265.9 6267.3 6267.7 6294.7 6028.2 6074.5 6074.8 6084.8 6085.5 5920.9 5945.1 6009.7 6093.1 6164.2 6109.1 6109.3 6112.3 6120.1 6123.1 5839.5 5844.8 5849.0 5905.4 6110.8 4563.0 4639.1 4645.8 4646.2 4647.5 4163.8 4167.7 4168.9 4176.7 4193.9 5808.1 5830.0 5838.2 5844.9 5847.5 6100.1 6105.8 6112.9 6113.1 6121.5 5643.7 5695.2 5764.9 5789.2 5846.5 5225.6 5232.6 5232.7 5233.3 5257.3 6318.1 6326.4 6366.8 6379.7 6385.4 5950.1 5994.4 6005.4 6008.1 6010.1 6257.8 6260.5 6261.1 6264.2 6314.9 6074.7 6084.6 6108.2 6116.7 6124.4 6132.5 6171.8 6182.8 6183.0 6184.3 5809.9 6007.2 6008.1 6013.2 6013.5 5899.3 5942.7 5945.7 5970.4 5983.1 5975.6 5989.1 5995.2 5997.5 6003.9 5791.4 6031.5 6042.6 6055.9 6060.2 5763.7 5847.9 5869.1 5905.3 5905.5 02:54:27 INFO - PROCESS | 21355 | 02:54:27 INFO - PROCESS | 21355 | [#1] ext.html Cycles:180 Average:44812.00 Median:173945.92 stddev:71568.59 (41.1%) stddev-sans-first:71692.88 02:54:27 INFO - PROCESS | 21355 | Values: 746.9 806.7 826.4 880.1 893.4 31723.0 43887.1 44563.6 44678.8 44755.0 47578.8 47750.0 47752.8 47804.0 47881.5 6833.0 6961.6 9314.6 9453.3 9459.1 10823.4 11078.7 11099.9 11102.3 11551.0 11234.8 11292.3 11293.8 11295.7 11300.2 11196.4 11199.6 11226.9 11239.0 11248.4 10865.7 10897.1 10918.9 10920.1 10923.9 43168.0 43359.8 43407.6 43419.6 43467.6 4363.8 4378.6 4399.4 4487.6 4529.3 30623.7 31602.8 31821.8 32028.0 32689.0 4355.1 4391.3 4449.9 4529.8 4544.3 229163.0 231614.8 231797.0 231931.0 233572.0 55126.0 55153.7 55326.7 55363.7 55483.4 57413.0 57504.4 57704.7 57776.7 57843.4 16403.2 16499.4 16530.2 16550.1 16564.9 12521.2 12769.4 14285.2 14638.9 14641.7 13931.6 14089.1 14157.8 14205.2 14209.0 5351.5 5391.9 5456.3 5520.4 5587.5 1003.3 1007.4 1013.6 1015.0 1020.7 29067.6 29099.9 29124.0 29282.9 29386.1 1070.5 1094.1 1097.6 1098.9 1102.3 14589.3 15234.7 15442.2 15534.6 15802.5 314893.0 315492.0 316289.0 316364.0 316447.0 57970.0 58121.0 58170.0 58171.4 58221.7 1466.3 1479.2 1507.8 1537.7 1545.0 25855.9 28860.3 29299.4 29468.4 29912.4 41293.4 41509.8 41524.0 41564.4 41795.4 268012.0 268965.0 270290.0 271109.2 271577.0 27960.0 28774.3 30770.7 31707.2 34565.5 35523.0 36758.4 45219.3 45813.0 45833.3 31861.0 32370.2 32495.7 32669.5 32876.9 31913.7 32080.4 32088.1 32159.7 32637.2 35157.8 35284.6 35308.5 35310.1 35749.6 30672.2 30791.7 31225.8 31264.4 31641.1 24376.4 25223.0 25422.0 25718.6 25785.5 02:54:27 INFO - PROCESS | 21355 | 02:54:27 INFO - PROCESS | 21355 | [#2] jquery.html Cycles:180 Average:37649.45 Median:12712.39 stddev:109166.25 (858.7%) stddev-sans-first:109436.71 02:54:27 INFO - PROCESS | 21355 | Values: 429.1 451.1 455.8 460.1 476.0 18253.3 19973.7 20374.4 20457.7 22254.1 20968.2 23147.3 23209.9 23256.3 23472.6 6618.1 6625.7 6897.9 6904.7 6919.7 6640.6 6647.1 6705.6 6706.7 6754.3 6631.6 6672.3 6674.7 6675.1 6728.2 6576.4 6708.0 6757.6 6770.2 6772.3 6589.6 6621.6 6625.2 6628.6 6636.9 25165.2 25388.9 25405.9 25426.0 25904.4 3017.2 3111.5 3128.8 3131.4 3187.6 16790.8 16881.9 16952.7 16968.2 17103.4 2238.3 2264.6 2277.5 2335.4 2347.3 98854.5 99227.0 99511.5 100006.5 101317.0 18158.4 18225.5 18355.8 18425.9 18606.4 32831.0 32839.0 32853.7 32916.7 33063.2 10734.5 10801.7 10866.8 10876.7 10920.1 9118.8 9181.2 9197.3 9405.5 9467.7 9308.4 9336.3 9461.0 9708.7 9722.9 3769.6 3770.9 3774.5 3844.0 3919.2 969.8 973.5 976.5 982.7 987.6 20019.5 21568.9 22243.9 22449.6 22560.2 1093.4 1101.4 1102.1 1124.7 1141.4 11333.3 11355.4 11479.3 11533.9 11734.5 652854.0 656875.0 667279.0 670628.0 671775.0 110223.0 114409.1 119565.0 120808.4 122399.0 1337.5 1409.9 1411.1 1412.4 1425.6 18591.9 19084.1 19281.0 19285.0 19531.6 45849.0 47087.8 47829.0 50214.7 50321.5 67634.3 67768.0 68327.0 69959.7 70359.0 12614.8 13111.4 13354.8 13358.9 13487.1 14761.0 14956.9 15142.8 15164.8 15464.1 12715.3 12815.8 12822.5 13097.1 13104.6 11576.9 11681.7 12111.7 12137.2 12340.8 12451.4 12713.4 12821.7 13032.6 13082.4 12804.0 13013.3 13092.7 13095.3 13365.0 12339.4 12549.5 12629.4 12939.1 12951.2 02:54:27 INFO - PROCESS | 21355 | 02:54:27 INFO - PROCESS | 21355 | [#3] mootools.html Cycles:180 Average:6983.47 Median:2397.12 stddev:4374.30 (182.5%) stddev-sans-first:4366.51 02:54:27 INFO - PROCESS | 21355 | Values: 1408.0 1551.9 1574.1 1587.5 1589.2 9141.5 10415.4 10724.2 10748.0 10748.6 10858.8 10903.1 10905.0 10921.7 10925.0 1950.9 2020.8 2383.8 2409.5 2410.7 2363.1 2414.8 2424.2 2427.0 2432.7 2392.1 2392.8 2406.6 2408.3 2419.5 2376.7 2391.9 2394.7 2399.6 2400.8 2298.1 2320.1 2357.0 2359.2 2364.0 11142.4 11197.0 11203.1 11203.5 11219.2 5688.9 5808.7 5830.6 5852.1 5861.0 3339.2 3474.5 3661.9 3673.7 3697.0 1335.2 1336.4 1345.2 1419.8 1434.7 16107.8 16115.8 16132.5 16160.4 16160.8 4655.2 4717.8 4733.9 4777.5 4795.1 13605.0 13609.8 13633.0 13634.2 13637.0 5811.2 5835.1 5874.4 5914.3 5916.3 5186.1 5267.2 5304.8 5313.3 5415.2 4043.6 4140.6 4160.8 4167.4 4178.4 1109.3 1110.2 1126.5 1128.2 1134.9 1070.7 1086.2 1087.3 1088.9 1093.0 7050.8 7110.9 7135.2 7172.7 7188.3 1066.9 1073.9 1116.4 1153.5 1158.3 4522.8 4758.1 4798.2 4806.6 4823.2 13735.7 13871.9 14075.0 14273.9 14311.1 13956.4 14158.2 14191.7 14264.0 14363.4 9630.6 9885.8 10374.2 10536.6 10543.2 7120.5 7213.4 7271.3 7358.3 7431.9 12358.4 12467.6 12535.4 12931.0 13076.2 12460.5 12616.6 12723.2 12734.7 12969.3 9421.3 9525.6 9563.7 9611.3 9658.9 10347.6 10404.2 10478.6 10486.8 10505.5 8726.6 8743.1 8764.9 8860.6 8918.6 8459.5 8664.0 8681.6 8808.6 8958.5 8262.9 8284.5 8428.5 8442.6 8481.2 6191.5 6306.8 6320.3 6339.8 6621.5 6410.2 6508.7 6543.2 6570.1 6663.4 02:54:27 INFO - PROCESS | 21355 | 02:54:27 INFO - PROCESS | 21355 | [#4] prototype.html Cycles:180 Average:4883.94 Median:5341.79 stddev:1243.79 (23.3%) stddev-sans-first:1201.19 02:54:27 INFO - PROCESS | 21355 | Values: 414.8 421.2 421.6 425.4 431.4 5266.6 5279.5 5319.9 5375.6 5388.6 5203.6 5207.6 5227.3 5227.8 5260.2 4448.5 4481.5 4564.3 4569.6 4621.6 4566.7 4609.8 4620.6 4637.8 4644.4 4476.8 4620.6 4638.7 4639.3 4670.2 4378.2 4524.9 4534.4 4578.7 4580.8 4393.9 4404.9 4422.0 4431.8 4445.8 5164.5 5172.4 5178.2 5181.6 5225.1 5133.4 5254.2 5269.0 5321.2 5361.6 5529.8 5537.4 5561.2 5562.1 5606.7 4869.9 4890.9 4909.5 4916.5 4933.8 5475.8 5558.3 5622.6 5817.9 5830.5 4920.6 4987.8 5019.2 5066.8 5080.6 5174.5 5175.6 5190.2 5198.3 5207.8 5117.7 5179.5 5199.4 5251.9 5284.7 5496.3 5505.8 5509.2 5540.0 5548.5 1772.2 1772.7 1781.7 1790.5 1802.5 1452.9 1457.0 1467.9 1476.4 1505.5 5366.0 5388.0 5394.3 5404.5 5432.6 5351.9 5608.7 5659.5 5672.5 5708.6 5286.8 5309.6 5355.5 5408.7 5413.4 2947.0 2957.8 2982.9 2983.9 2985.5 5572.6 5814.7 5820.3 5870.7 5885.6 5711.0 5729.4 5730.7 5734.8 5745.3 5859.4 5865.7 5892.4 5919.9 5920.9 5383.5 5666.2 5677.5 5681.8 5686.8 5336.4 5546.8 5626.9 5630.6 5644.9 5477.2 5613.4 5641.6 5692.5 5851.9 4689.5 4713.5 4739.3 4756.4 4771.2 5542.3 5618.3 5630.7 5700.9 5729.1 5494.6 5498.2 5526.0 5555.1 5580.6 5479.4 5515.9 5516.9 5530.9 5561.9 5347.2 5443.1 5491.7 5495.6 5522.8 5529.4 5537.0 5538.4 5541.0 5543.8 5220.8 5416.6 5419.4 5433.6 5433.8 02:54:27 INFO - PROCESS | 21355 | 02:54:27 INFO - PROCESS | 21355 | [#5] yui.html Cycles:180 Average:18712.73 Median:45907.93 stddev:22801.04 (49.7%) stddev-sans-first:22825.67 02:54:27 INFO - PROCESS | 21355 | Values: 878.0 878.9 884.2 890.6 918.9 16708.8 18318.4 18322.3 18364.7 18384.0 16355.9 16845.5 16995.8 17006.7 17008.1 702.1 713.6 887.3 889.7 902.1 909.6 912.0 912.7 914.7 915.7 958.5 963.0 963.5 964.5 965.1 958.8 959.0 959.0 960.3 960.8 704.2 704.4 705.3 705.7 706.2 17183.7 17215.9 17377.8 17923.5 18136.7 17145.5 17202.8 17449.0 17521.6 17811.3 13375.9 13521.6 13639.5 13775.4 13838.1 4142.5 4154.8 4226.0 4294.1 4358.9 66160.0 66987.3 77767.2 88155.0 89435.6 13905.0 13931.3 13987.0 14006.3 14078.8 26201.2 26313.9 26383.2 26465.3 26478.2 9553.3 9583.0 9756.7 9772.3 9829.6 5155.1 5176.4 5203.3 5309.0 5336.1 3907.8 3992.6 4013.8 4015.3 4022.7 625.3 630.4 641.1 651.7 659.0 850.8 866.4 873.4 874.3 881.3 11686.9 11713.4 11822.5 11963.2 12232.9 819.3 845.5 853.8 865.7 874.3 5508.9 5545.1 5613.8 5679.6 5718.4 77760.0 78220.6 78753.6 79805.0 83205.6 71363.6 72051.0 73298.0 74581.0 75143.6 65199.7 65442.3 66055.3 66644.0 67038.0 10738.5 10952.3 11103.8 11244.2 11278.0 45501.3 46314.5 46543.0 46798.8 46838.0 52457.2 52598.2 52969.0 53091.0 54328.5 13801.4 13969.2 14068.5 14113.3 14197.9 14354.2 14498.3 14835.9 15102.7 15489.2 13425.7 13867.6 13875.7 13933.0 14150.8 10344.6 14018.9 14036.2 14126.7 14220.1 13860.7 14187.7 14339.4 14396.4 14506.5 11359.9 11413.9 11537.1 11701.3 12018.6 12174.3 12221.7 12327.9 12537.2 12927.9 02:54:27 INFO - PROCESS | 21355 | -------- Summary: end -------- 02:54:27 INFO - PROCESS | 21355 | 02:54:28 INFO - TEST-INFO | 21355: exit 0 02:54:28 INFO - TEST-OK | dromaeo_css | took 1115373ms 02:54:28 INFO - TEST-START | kraken 02:54:28 INFO - operating with platform_type : linux_ 02:54:28 INFO - Initialising browser for kraken test... 02:54:28 INFO - TEST-INFO | started process 21665 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_MzHJ3/profile http://localhost:60748/getInfo.html) 02:54:32 INFO - PROCESS | 21665 | __metrics Screen width/height:1600/1200 02:54:32 INFO - PROCESS | 21665 | colorDepth:24 02:54:32 INFO - PROCESS | 21665 | Browser inner width/height: 1024/697 02:54:32 INFO - PROCESS | 21665 | __metrics 02:54:33 INFO - PROCESS | 21665 | 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" 02:54:33 INFO - PROCESS | 21665 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:54:34 INFO - TEST-INFO | 21665: exit 0 02:54:34 INFO - Browser initialized. 02:54:34 INFO - Running cycle 1/1 for kraken test... 02:54:34 INFO - TEST-INFO | started process 21757 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_MzHJ3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:54:46 INFO - PROCESS | 21757 | RSS: Main: 141180928 02:54:46 INFO - PROCESS | 21757 | 02:54:48 INFO - PROCESS | 21757 | Cycle 1(1): loaded http://localhost:60748/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60748/tests/kraken/driver.html?testName=audio-beat-detection) 02:54:49 INFO - PROCESS | 21757 | RSS: Main: 184098816 02:54:49 INFO - PROCESS | 21757 | 02:54:52 INFO - PROCESS | 21757 | Cycle 1(1): loaded http://localhost:60748/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60748/tests/kraken/driver.html?testName=audio-dft) 02:54:52 INFO - PROCESS | 21757 | RSS: Main: 173125632 02:54:52 INFO - PROCESS | 21757 | 02:54:55 INFO - PROCESS | 21757 | Cycle 1(1): loaded http://localhost:60748/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60748/tests/kraken/driver.html?testName=audio-fft) 02:54:56 INFO - PROCESS | 21757 | RSS: Main: 265125888 02:54:56 INFO - PROCESS | 21757 | 02:54:58 INFO - PROCESS | 21757 | Cycle 1(1): loaded http://localhost:60748/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60748/tests/kraken/driver.html?testName=audio-oscillator) 02:54:58 INFO - PROCESS | 21757 | RSS: Main: 171491328 02:54:58 INFO - PROCESS | 21757 | 02:55:00 INFO - PROCESS | 21757 | Cycle 1(1): loaded http://localhost:60748/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60748/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:55:01 INFO - PROCESS | 21757 | RSS: Main: 174297088 02:55:01 INFO - PROCESS | 21757 | 02:55:04 INFO - PROCESS | 21757 | Cycle 1(1): loaded http://localhost:60748/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60748/tests/kraken/driver.html?testName=imaging-darkroom) 02:55:04 INFO - PROCESS | 21757 | RSS: Main: 211521536 02:55:04 INFO - PROCESS | 21757 | 02:55:08 INFO - PROCESS | 21757 | Cycle 1(1): loaded http://localhost:60748/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60748/tests/kraken/driver.html?testName=imaging-desaturate) 02:55:08 INFO - PROCESS | 21757 | RSS: Main: 212557824 02:55:08 INFO - PROCESS | 21757 | 02:55:11 INFO - PROCESS | 21757 | Cycle 1(1): loaded http://localhost:60748/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60748/tests/kraken/driver.html?testName=json-parse-financial) 02:55:12 INFO - PROCESS | 21757 | RSS: Main: 211996672 02:55:12 INFO - PROCESS | 21757 | 02:55:13 INFO - PROCESS | 21757 | Cycle 1(1): loaded http://localhost:60748/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60748/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:55:14 INFO - PROCESS | 21757 | RSS: Main: 173727744 02:55:14 INFO - PROCESS | 21757 | 02:55:15 INFO - PROCESS | 21757 | Cycle 1(1): loaded http://localhost:60748/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60748/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:55:16 INFO - PROCESS | 21757 | RSS: Main: 180146176 02:55:16 INFO - PROCESS | 21757 | 02:55:18 INFO - PROCESS | 21757 | Cycle 1(1): loaded http://localhost:60748/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60748/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:55:19 INFO - PROCESS | 21757 | RSS: Main: 185188352 02:55:19 INFO - PROCESS | 21757 | 02:55:21 INFO - PROCESS | 21757 | Cycle 1(1): loaded http://localhost:60748/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60748/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:55:22 INFO - PROCESS | 21757 | RSS: Main: 182452224 02:55:22 INFO - PROCESS | 21757 | 02:55:25 INFO - PROCESS | 21757 | Cycle 1(1): loaded http://localhost:60748/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60748/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:55:25 INFO - PROCESS | 21757 | RSS: Main: 184672256 02:55:25 INFO - PROCESS | 21757 | 02:55:27 INFO - PROCESS | 21757 | Cycle 1(1): loaded http://localhost:60748/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60748/tests/kraken/driver.html?testName=ai-astar) 02:55:27 INFO - PROCESS | 21757 | RSS: Main: 237834240 02:55:27 INFO - PROCESS | 21757 | 02:55:27 INFO - PROCESS | 21757 | __start_tp_report 02:55:27 INFO - PROCESS | 21757 | _x_x_mozilla_page_load 02:55:27 INFO - PROCESS | 21757 | _x_x_mozilla_page_load_details 02:55:27 INFO - PROCESS | 21757 | |i|pagename|runs| 02:55:27 INFO - PROCESS | 21757 | |0;ai-astar;104;112;113;112;113;114;113;114;112;112 02:55:27 INFO - PROCESS | 21757 | |1;audio-beat-detection;138;116;118;156;115;118;116;114;135;116 02:55:27 INFO - PROCESS | 21757 | |2;audio-dft;161;161;160;163;161;162;161;161;159;162 02:55:27 INFO - PROCESS | 21757 | |3;audio-fft;74;74;76;113;75;75;75;77;95;75 02:55:27 INFO - PROCESS | 21757 | |4;audio-oscillator;82;82;102;82;82;82;100;81;82;113 02:55:27 INFO - PROCESS | 21757 | |5;imaging-gaussian-blur;112;113;112;115;113;112;113;112;113;112 02:55:27 INFO - PROCESS | 21757 | |6;imaging-darkroom;147;147;146;147;146;145;146;146;146;146 02:55:27 INFO - PROCESS | 21757 | |7;imaging-desaturate;94;95;94;94;93;94;94;94;94;94 02:55:27 INFO - PROCESS | 21757 | |8;json-parse-financial;56;53;56;55;54;55;55;54;55;54 02:55:27 INFO - PROCESS | 21757 | |9;json-stringify-tinderbox;53;53;52;54;53;53;53;53;53;54 02:55:27 INFO - PROCESS | 21757 | |10;stanford-crypto-aes;80;75;87;79;74;79;82;76;84;105 02:55:27 INFO - PROCESS | 21757 | |11;stanford-crypto-ccm;124;120;124;126;119;125;116;118;140;122 02:55:27 INFO - PROCESS | 21757 | |12;stanford-crypto-pbkdf2;155;157;156;165;155;155;161;164;157;156 02:55:27 INFO - PROCESS | 21757 | |13;stanford-crypto-sha256-iterative;62;61;59;60;59;59;60;59;58;58 02:55:27 INFO - PROCESS | 21757 | __end_tp_report 02:55:27 INFO - PROCESS | 21757 | __start_cc_report 02:55:27 INFO - PROCESS | 21757 | _x_x_mozilla_cycle_collect,1596 02:55:27 INFO - PROCESS | 21757 | __end_cc_report 02:55:27 INFO - PROCESS | 21757 | __startTimestamp1496397327465__endTimestamp 02:55:27 INFO - PROCESS | 21757 | 02:55:27 INFO - PROCESS | 21757 | ------- Summary: start ------- 02:55:27 INFO - PROCESS | 21757 | Number of tests: 14 02:55:27 INFO - PROCESS | 21757 | 02:55:27 INFO - PROCESS | 21757 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:2.88 (2.6%) stddev-sans-first:0.83 02:55:27 INFO - PROCESS | 21757 | Values: 104.0 112.0 113.0 112.0 113.0 114.0 113.0 114.0 112.0 112.0 02:55:27 INFO - PROCESS | 21757 | 02:55:27 INFO - PROCESS | 21757 | [#1] audio-beat-detection Cycles:10 Average:124.20 Median:118.00 stddev:14.09 (11.9%) stddev-sans-first:14.03 02:55:27 INFO - PROCESS | 21757 | Values: 138.0 116.0 118.0 156.0 115.0 118.0 116.0 114.0 135.0 116.0 02:55:27 INFO - PROCESS | 21757 | 02:55:27 INFO - PROCESS | 21757 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 02:55:27 INFO - PROCESS | 21757 | Values: 161.0 161.0 160.0 163.0 161.0 162.0 161.0 161.0 159.0 162.0 02:55:27 INFO - PROCESS | 21757 | 02:55:27 INFO - PROCESS | 21757 | [#3] audio-fft Cycles:10 Average:80.90 Median:75.00 stddev:12.92 (17.2%) stddev-sans-first:13.46 02:55:27 INFO - PROCESS | 21757 | Values: 74.0 74.0 76.0 113.0 75.0 75.0 75.0 77.0 95.0 75.0 02:55:27 INFO - PROCESS | 21757 | 02:55:27 INFO - PROCESS | 21757 | [#4] audio-oscillator Cycles:10 Average:88.80 Median:82.00 stddev:11.66 (14.2%) stddev-sans-first:12.10 02:55:27 INFO - PROCESS | 21757 | Values: 82.0 82.0 102.0 82.0 82.0 82.0 100.0 81.0 82.0 113.0 02:55:27 INFO - PROCESS | 21757 | 02:55:27 INFO - PROCESS | 21757 | [#5] imaging-gaussian-blur Cycles:10 Average:112.70 Median:113.00 stddev:0.95 (0.8%) stddev-sans-first:0.97 02:55:27 INFO - PROCESS | 21757 | Values: 112.0 113.0 112.0 115.0 113.0 112.0 113.0 112.0 113.0 112.0 02:55:27 INFO - PROCESS | 21757 | 02:55:27 INFO - PROCESS | 21757 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 02:55:27 INFO - PROCESS | 21757 | Values: 147.0 147.0 146.0 147.0 146.0 145.0 146.0 146.0 146.0 146.0 02:55:27 INFO - PROCESS | 21757 | 02:55:27 INFO - PROCESS | 21757 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 02:55:27 INFO - PROCESS | 21757 | Values: 94.0 95.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 94.0 02:55:27 INFO - PROCESS | 21757 | 02:55:27 INFO - PROCESS | 21757 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:0.95 (1.7%) stddev-sans-first:0.88 02:55:27 INFO - PROCESS | 21757 | Values: 56.0 53.0 56.0 55.0 54.0 55.0 55.0 54.0 55.0 54.0 02:55:27 INFO - PROCESS | 21757 | 02:55:27 INFO - PROCESS | 21757 | [#9] json-stringify-tinderbox Cycles:10 Average:53.10 Median:53.00 stddev:0.57 (1.1%) stddev-sans-first:0.60 02:55:27 INFO - PROCESS | 21757 | Values: 53.0 53.0 52.0 54.0 53.0 53.0 53.0 53.0 53.0 54.0 02:55:27 INFO - PROCESS | 21757 | 02:55:27 INFO - PROCESS | 21757 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:79.50 stddev:9.00 (11.3%) stddev-sans-first:9.51 02:55:27 INFO - PROCESS | 21757 | Values: 80.0 75.0 87.0 79.0 74.0 79.0 82.0 76.0 84.0 105.0 02:55:27 INFO - PROCESS | 21757 | 02:55:27 INFO - PROCESS | 21757 | [#11] stanford-crypto-ccm Cycles:10 Average:123.40 Median:124.00 stddev:6.69 (5.4%) stddev-sans-first:7.09 02:55:27 INFO - PROCESS | 21757 | Values: 124.0 120.0 124.0 126.0 119.0 125.0 116.0 118.0 140.0 122.0 02:55:27 INFO - PROCESS | 21757 | 02:55:27 INFO - PROCESS | 21757 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.10 Median:157.00 stddev:3.81 (2.4%) stddev-sans-first:3.88 02:55:27 INFO - PROCESS | 21757 | Values: 155.0 157.0 156.0 165.0 155.0 155.0 161.0 164.0 157.0 156.0 02:55:27 INFO - PROCESS | 21757 | 02:55:27 INFO - PROCESS | 21757 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.50 Median:59.50 stddev:1.27 (2.1%) stddev-sans-first:0.97 02:55:27 INFO - PROCESS | 21757 | Values: 62.0 61.0 59.0 60.0 59.0 59.0 60.0 59.0 58.0 58.0 02:55:27 INFO - PROCESS | 21757 | -------- Summary: end -------- 02:55:27 INFO - PROCESS | 21757 | 02:55:28 INFO - TEST-INFO | 21757: exit 0 02:55:28 INFO - TEST-OK | kraken | took 60053ms 02:55:28 INFO - SUITE-END | took 1175s 02:55:28 INFO - Completed test suite (00:19:35) 02:55:28 INFO - javascript benchmark 02:55:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7899.943976029133, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3367.0, 3369.494575813626, 3404.200012996946, 3407.2333724911914, 3457.4640930655755, 5641.492265696086, 5706.115552089433, 5718.771249150034, 5721.113227449752, 5724.685142317171, 5652.773889044443, 5684.062129748587, 5726.942730572693, 5734.512566431858, 5754.16564598133, 5194.27280180775, 5196.142636464988, 5211.062008838408, 5244.239585260135, 5273.314469119009, 5081.034603425356, 5100.387953445573, 5281.70950597717, 5293.311869456965, 5320.813771517997, 5194.039102765982, 5200.791968321262, 5220.947790522084, 5232.215167724853, 5240.318758561381, 5290.92063619046, 5292.020976119411, 5301.098813201726, 5302.3902251241025, 5303.443138470482, 5016.44819069902, 5149.639525233235, 5213.165893457067, 5262.894742105174, 5272.393674727417, 5570.721463926788, 5577.3028371453565, 5679.375268720438, 5690.260266165414, 5691.089425691911, 6132.816015519497, 6173.32093469718, 6173.660448675321, 6181.845453863644, 6181.845453863644, 6196.845078873019, 6197.225346831646, 6201.317855035943, 6213.627182369072, 6214.5960512566535, 5587.55299576037, 5625.578081643852, 5725.856853578611, 5727.4845263926445, 5731.140328950607, 6261.841559311542, 6265.937340626535, 6267.310595834455, 6267.65527895961, 6294.716737746812, 6028.186194863637, 6074.453299203093, 6074.848128796815, 6084.787032453932, 6085.5435842312, 5920.940790592125, 5945.10823376497, 6009.729562169713, 6093.086037094471, 6164.229471316085, 6109.14471973924, 6109.28320792043, 6112.266528016667, 6120.051392034242, 6123.08153776937, 5839.474447299764, 5844.766209351578, 5849.034909240013, 5905.40945905406, 6110.832160914, 4562.954370456253, 4639.141758774637, 4645.767711614406, 4646.233371493666, 4647.512011238839, 4163.770992595376, 4167.74993500391, 4168.895777605584, 4176.749395036308, 4193.874183774492, 5808.128780682847, 5829.970850145722, 5838.153467747153, 5844.94155058444, 5847.473727364558, 6100.115483254903, 6105.84735381619, 6112.877742445126, 6113.083037544404, 6121.47967422774, 5643.661380317194, 5695.231143795535, 5764.913526297109, 5789.218455508537, 5846.532277417797, 5225.555827754607, 5232.607554433433, 5232.659877107976, 5233.267342572043, 5257.263983042377, 6318.0838778375955, 6326.367363263729, 6366.84082897922, 6379.744810207632, 6385.425311721968, 5950.107483877453, 5994.400559943971, 6005.3694362091355, 6008.098785182257, 6010.128531363015, 6257.843553911189, 6260.467860231931, 6261.092141639528, 6264.248290205022, 6314.936850631435, 6074.7266373012435, 6084.60450070744, 6108.205933228652, 6116.694165291807, 6124.38756124384, 6132.478739307209, 6171.783987560414, 6182.814515564541, 6183.041628547582, 6184.288806787097, 5809.883802324014, 6007.189029480965, 6008.068749343859, 6013.218281623536, 6013.548983826143, 5899.292084949833, 5942.73257703413, 5945.672987985702, 5970.432808883149, 5983.132445795248, 5975.611585247119, 5989.071693887455, 5995.190649262294, 5997.520198384206, 6003.909941350796, 5791.362950075572, 6031.5476339273855, 6042.577019608585, 6055.939440605714, 6060.212172417558, 5763.682997435181, 5847.912281315868, 5869.06095024811, 5905.320888097924, 5905.498032667099], "value": 5638.040920864472, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.9439792015601, 806.6773290683726, 826.4132465949174, 880.0891077734547, 893.3746377535726, 31723.0, 43887.12225755483, 44563.554364456344, 44678.776606116924, 44754.999999999956, 47578.762106189504, 47750.0, 47752.76123619386, 47804.0, 47881.521184788144, 6833.0, 6961.617111058889, 9314.580843862042, 9453.291003174754, 9459.10138536838, 10823.350598964047, 11078.723031924226, 11099.889001109967, 11102.2783519071, 11551.018163456116, 11234.775304493905, 11292.322460652345, 11293.830592541119, 11295.661130166067, 11300.15248856335, 11196.384198869058, 11199.60801371948, 11226.943865280662, 11239.0, 11248.38133902635, 10865.674029779118, 10897.073748731367, 10918.945405273002, 10920.12638988879, 10923.945380273048, 43168.0, 43359.78320108411, 43407.56592434067, 43419.565804341866, 43467.565324346986, 4363.80362883671, 4378.580323785804, 4399.3840862278985, 4487.618552423048, 4529.297958816356, 30623.693763062307, 31602.841985789924, 31821.84089079563, 32028.0, 32689.0, 4355.107203023373, 4391.341298805173, 4449.866504004885, 4529.796159172845, 4544.341070544752, 229163.0, 231614.84192579097, 231797.0, 231931.0, 233572.0, 55126.0, 55153.72423137858, 55326.72336638291, 55363.72318138384, 55483.445165547826, 57413.0, 57504.42495575074, 57704.711476442346, 57776.71111644499, 57843.42156578381, 16403.179841007903, 16499.422520211734, 16530.173491325626, 16550.089745063895, 16564.917175414044, 12521.186122901981, 12769.425375858109, 14285.214313212873, 14638.926805365905, 14641.707165856624, 13931.58205253844, 14089.084209526349, 14157.787633185511, 14205.218712970885, 14209.0, 5351.464853514695, 5391.9460805391445, 5456.345238571397, 5520.3651580068, 5587.525060369914, 1003.3127307794184, 1007.3955626623967, 1013.6401577439902, 1014.9644762433279, 1020.6733845169474, 29067.56398654022, 29099.85450072736, 29124.048525214315, 29282.853585731937, 29386.11841644754, 1070.5236169904474, 1094.0645747885603, 1097.5884043483693, 1098.9340639561651, 1102.311055590256, 14589.343479543233, 15234.695306093816, 15442.227888605525, 15534.611634708997, 15802.525924222291, 314893.0, 315492.0, 316289.0, 316364.0, 316447.0, 57970.0, 58121.0, 58170.0, 58171.4182858166, 58221.70889145527, 1466.34747537347, 1479.2234077109388, 1507.773833924898, 1537.7102766483263, 1545.0420739141805, 25855.870720646275, 28860.278493037003, 29299.41401171922, 29468.410631787672, 29912.401751964404, 41293.38059929164, 41509.79245103755, 41524.0, 41564.3765343514, 41795.37306940337, 268012.0, 268965.0, 270290.0, 271109.15563377243, 271577.0, 27960.0, 28774.280642983256, 30770.692293076783, 31707.207319816265, 34565.48151777776, 35523.0, 36758.44862327014, 45219.32171017372, 45813.0, 45833.312500311855, 31861.0, 32370.190745231557, 32495.675043249266, 32669.509957350183, 32876.86300390467, 31913.68086319107, 32080.35839283248, 32088.074715517145, 32159.67840321567, 32637.18407039843, 35157.82421087878, 35284.64715352814, 35308.47037294391, 35310.11724706903, 35749.64250357463, 30672.233194169432, 30791.69208307978, 31225.8438707805, 31264.374712506076, 31641.050768476063, 24376.390590234678, 25223.0, 25422.0, 25718.614220787076, 25785.484290314464], "value": 19074.90972204302, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.14599946107256, 451.1023064102437, 455.8153947651201, 460.0637702275867, 475.9809607615696, 18253.269869205233, 19973.700394494077, 20374.388768336972, 20457.693134602956, 22254.109835606578, 20968.217701495352, 23147.30558083256, 23209.883950580264, 23256.302310930656, 23472.64791028136, 6618.106555614979, 6625.668716564177, 6897.931020689804, 6904.723811047552, 6919.6540172991145, 6640.634765087918, 6647.135872336614, 6705.597664140143, 6706.731730730765, 6754.257031726506, 6631.568948018387, 6672.299408562079, 6674.6662666866705, 6675.098861653688, 6728.158980127484, 6576.4410025147445, 6708.0, 6757.560758550679, 6770.1537307836525, 6772.322767723213, 6589.571677840925, 6621.602703837737, 6625.238097618787, 6628.5691430056895, 6636.93363066368, 25165.24504264875, 25388.873055634787, 25405.872970635028, 25426.0, 25904.352391190183, 3017.2456885778556, 3111.48660471022, 3128.765342599291, 3131.373725254958, 3187.585613870182, 16790.83209167917, 16881.915590422093, 16952.660946780994, 16968.151592420454, 17103.401380951607, 2238.250186187629, 2264.615015447378, 2277.464795772992, 2335.381124002141, 2347.260612906929, 98854.50572747162, 99227.0, 99511.50244248733, 100006.4999674997, 101317.0, 18158.365747082826, 18225.544361391072, 18355.81644183568, 18425.907870460564, 18606.44180674582, 32831.0, 32839.0, 32853.67146328554, 32916.67083329184, 33063.17342066467, 10734.463276836126, 10801.729956751144, 10866.836997445045, 10876.673699789018, 10920.12638988879, 9118.81762364749, 9181.219596334386, 9197.310201734897, 9405.482698451651, 9467.715968520955, 9308.44149351041, 9336.299777516577, 9461.0, 9708.689326940914, 9722.867781192965, 3769.566499852497, 3770.8868733938025, 3774.5281839770028, 3843.9807800961376, 3919.196564704229, 969.8496733006396, 973.454865275448, 976.5263847034183, 982.651158838602, 987.6148302162162, 20019.499512512302, 21568.892155539437, 22243.888780555993, 22449.551008979728, 22560.210392636178, 1093.371311495893, 1101.3777215873006, 1102.090775110537, 1124.656979621207, 1141.3919194640207, 11333.263337883176, 11355.432228388712, 11479.253848499988, 11533.942330288295, 11734.530618775154, 652854.0, 656875.0, 667279.0, 670628.0, 671775.0, 110223.0, 114409.14462773062, 119565.0, 120808.39595801965, 122399.0, 1337.518493342396, 1409.8519655436237, 1411.068694661498, 1412.3785534364847, 1425.5509514502899, 18591.90704046471, 19084.141213645697, 19281.035948202814, 19285.0, 19531.60936781228, 45849.0, 47087.76456117698, 47829.0, 50214.748926256594, 50321.496785033145, 67634.3236567628, 67768.0, 68327.0, 69959.65020174866, 70359.0, 12614.810777838524, 13111.409986550438, 13354.799678004643, 13358.86641133615, 13487.123336983064, 14761.0, 14956.925215373854, 15142.772858406912, 15164.772528412303, 15464.072155670696, 12715.300658463873, 12815.807762883751, 12822.487100516248, 13097.148685335424, 13104.606861794162, 11576.94211528937, 11681.707957301136, 12111.697207569881, 12137.211081280042, 12340.753184936431, 12451.439685214005, 12713.42789574453, 12821.743565128458, 13032.609021729364, 13082.411291492095, 12804.0, 13013.284269365276, 13092.738145237232, 13095.279759613313, 13365.0, 12339.444724987578, 12549.498020079094, 12629.431675574804, 12939.094263401848, 12951.222926624432], "value": 11641.844502064592, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1408.0284603623493, 1551.868091212247, 1574.1420925595553, 1587.5237428771366, 1589.237166160243, 9141.497217653026, 10415.375077495355, 10724.195685323612, 10748.0, 10748.570057197723, 10858.782824343529, 10903.073238774694, 10905.0, 10921.726956826084, 10925.0, 1950.882947023176, 2020.7777144514166, 2383.797377222934, 2409.5301416223842, 2410.650455683925, 2363.1492662641435, 2414.8309618326725, 2424.212131057405, 2427.0413186791206, 2432.70807503099, 2392.055138220402, 2392.7726865947707, 2406.590879550472, 2408.3377071305445, 2419.5281920025514, 2376.6910301660846, 2391.880405979694, 2394.6767186429784, 2399.568077746005, 2400.7719266669637, 2298.092253559851, 2320.0951628864755, 2357.03361621736, 2359.2214569192124, 2363.9527209455887, 11142.387168705718, 11197.048250898684, 11203.103751699844, 11203.495842687098, 11219.214654974156, 5688.914666280009, 5808.738606762664, 5830.562707796932, 5852.063669812809, 5860.97069514654, 3339.1819004344093, 3474.4614584739406, 3661.9450708239397, 3673.7061035117395, 3697.0, 1335.1588499245413, 1336.3518693433678, 1345.219772531929, 1419.8367187773435, 1434.7202295552372, 16107.838921610752, 16115.83884161155, 16132.516024519284, 16160.353585856552, 16160.75758863618, 4655.231886738718, 4717.811287548459, 4733.905321893543, 4777.546133117348, 4795.088933102699, 13605.0, 13609.795853062213, 13633.0, 13634.181949083088, 13637.0, 5811.15738217956, 5835.124731290341, 5874.353821079678, 5914.260717410324, 5916.290045194604, 5186.066508028591, 5267.209918512177, 5304.761285742151, 5313.256144139824, 5415.160650099241, 4043.6370865535387, 4140.627343539096, 4160.791960401968, 4167.437395951569, 4178.394132850781, 1109.3011402816173, 1110.2006555280186, 1126.5493802479075, 1128.1989787251143, 1134.9148813838995, 1070.6948519671855, 1086.2450596835124, 1087.3095584303867, 1088.8693356797078, 1092.9672109836717, 7050.823729406703, 7110.893336599956, 7135.215126336099, 7172.713091476387, 7188.317109874553, 1066.893310668927, 1073.9194560408, 1116.436199719153, 1153.5385845661801, 1158.3050169897995, 4522.841700540465, 4758.07217592573, 4798.160321943646, 4806.567408933212, 4823.155947709137, 13735.656608584864, 13871.861281387259, 14075.0, 14273.928630356782, 14311.069780464237, 13956.371963261678, 14158.221297828719, 14191.716165676835, 14264.0, 14363.425462981573, 9630.614775408905, 9885.75285617851, 10374.22193335503, 10536.578536858593, 10543.209259305582, 7120.537165084253, 7213.350798428167, 7271.3455788979245, 7358.264173582599, 7431.851362972819, 12358.44387002605, 12467.625971220878, 12535.373231338579, 12931.0, 13076.215427074407, 12460.501579936701, 12616.621501354974, 12723.23660580368, 12734.745305094031, 12969.286689232184, 9421.340506164503, 9525.57134928916, 9563.665271715456, 9611.327207095435, 9658.855117173107, 10347.63783267582, 10404.167666586807, 10478.633247836595, 10486.79026419452, 10505.474726263808, 8726.563671816257, 8743.081976392641, 8764.91235087641, 8860.601272942862, 8918.598663060047, 8459.534725590152, 8663.95668021656, 8681.609327580149, 8808.647654093764, 8958.507282099547, 8262.917370826215, 8284.46151000183, 8428.4942903426, 8442.577871106543, 8481.15188481147, 6191.473724733448, 6306.810795676137, 6320.336364681642, 6339.809805705836, 6621.536492445675, 6410.1987251593555, 6508.674566271762, 6543.1821022372205, 6570.08018877348, 6663.433608143362], "value": 5342.098371551419, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.75454568005364, 421.191312679655, 421.58684489200584, 425.3598334506567, 431.38527598172595, 5266.631335806495, 5279.524842764155, 5319.867003324919, 5375.596830237733, 5388.595855310853, 5203.557697595709, 5207.583393328534, 5227.3465816772905, 5227.79088836446, 5260.210968354749, 4448.466184057917, 4481.529439408864, 4564.292534657116, 4569.565891240343, 4621.58405743483, 4566.680332376735, 4609.819224734939, 4620.584147426731, 4637.768111594423, 4644.373009643706, 4476.843310484133, 4620.584147426731, 4638.744869032219, 4639.327297541854, 4670.206064968964, 4378.233809083397, 4524.932126018112, 4534.36518887356, 4578.725276483388, 4580.770961451947, 4393.890152746207, 4404.933925991113, 4421.977890110529, 4431.800568974404, 4445.844395446144, 5164.509371609729, 5172.353455818023, 5178.223266510016, 5181.600967738727, 5225.066725311621, 5133.358330208724, 5254.185601231815, 5269.0, 5321.2284218788445, 5361.571074314045, 5529.815722789475, 5537.446255374431, 5561.193626924114, 5562.137868630329, 5606.6636001839615, 4869.902601947977, 4890.948446084109, 4909.533594308535, 4916.50834916509, 4933.753312334369, 5475.753591088411, 5558.303728020902, 5622.606417550773, 5817.941820581782, 5830.47525722687, 4920.581750551171, 4987.775550100254, 5019.196928491424, 5066.771995260222, 5080.59355251579, 5174.456682048406, 5175.637705360588, 5190.169572868398, 5198.298229739013, 5207.7916883325, 5117.669405954479, 5179.507946745053, 5199.400299850075, 5251.947480525222, 5284.7052472143805, 5496.340439147248, 5505.752241149158, 5509.201165830932, 5539.972300138554, 5548.528375088163, 1772.1847949943171, 1772.7252275897256, 1781.6703909776734, 1790.543411430103, 1802.504311314373, 1452.8619781120776, 1457.0019536617451, 1467.8770740383616, 1476.372541669786, 1505.473084420466, 5365.973170134124, 5387.973060134675, 5394.271773310631, 5404.540614047772, 5432.592555558349, 5351.919721204107, 5608.719564021782, 5659.462351076641, 5672.461116193955, 5708.629928817054, 5286.788528458896, 5309.628326017219, 5355.544778693855, 5408.702521361363, 5413.377461591888, 2946.955795663067, 2957.816873250717, 2982.910512684623, 2983.895563655262, 2985.5223164293607, 5572.554195664337, 5814.738336774855, 5820.30156381237, 5870.706464676835, 5885.555860828802, 5711.001149597608, 5729.427057294321, 5730.656160630376, 5734.827955161351, 5745.3105627324985, 5859.414058594107, 5865.706714664249, 5892.381299963527, 5919.911201331984, 5920.911186332209, 5383.515483606494, 5666.206731057738, 5677.489025987681, 5681.829545113653, 5686.839001179525, 5336.359636843604, 5546.75039623226, 5626.943730562642, 5630.605857590093, 5644.88710225785, 5477.178423236546, 5613.382527921844, 5641.633293835887, 5692.516136128475, 5851.941480585139, 4689.546240665405, 4713.528647135259, 4739.312799644102, 4756.382829837872, 4771.188897887437, 5542.2795036644975, 5618.297712785902, 5630.690312032878, 5700.942990570041, 5729.140628905698, 5494.642848214853, 5498.202760599611, 5525.960721603183, 5555.083496193806, 5580.600341853042, 5479.383581843445, 5515.889682206413, 5516.862078448071, 5530.861728456821, 5561.943230786138, 5347.224652425454, 5443.080981693174, 5491.725413729378, 5495.587830912617, 5522.779088836563, 5529.419410961791, 5536.972315138399, 5538.44615538459, 5541.0, 5543.833684989457, 5220.843374698765, 5416.620836541404, 5419.376771671151, 5433.56531477473, 5433.809816656398], "value": 4529.670567344881, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [877.9868301975472, 878.912108789121, 884.1953822021961, 890.6481939633849, 918.8543561328822, 16708.832911670896, 18318.35885743999, 18322.267109315646, 18364.724529132072, 18384.0, 16355.91822040891, 16845.494635160932, 16995.83004169958, 17006.744898826528, 17008.06455644939, 702.0627462337785, 713.6182142553735, 887.2502735188755, 889.7375274294099, 902.0843843498853, 909.5906841921129, 911.9863202051974, 912.7079334612927, 914.6570036236411, 915.7344370132654, 958.4776296918161, 963.0, 963.4941655630815, 964.4599024546242, 965.0590674092773, 958.8034452937131, 958.9520523973808, 959.040959040959, 960.3085778239691, 960.7886265021684, 704.2183176673888, 704.4012589299106, 705.340506626306, 705.7318219076769, 706.1773034414952, 17183.742243866353, 17215.913920430445, 17377.826221737872, 17923.462296131136, 18136.727949080774, 17145.485635430956, 17202.82797172025, 17449.0, 17521.561960950952, 17811.287548498043, 13375.866241337559, 13521.577250805789, 13639.454421823115, 13775.448982040707, 13838.100523465942, 4142.46148000761, 4154.813033413473, 4225.9788701056605, 4294.098239369736, 4358.869233922956, 66160.0, 66987.33012669909, 77767.22232777656, 88155.0, 89435.55282223548, 13905.0, 13931.303434828218, 13987.0, 14006.299685015912, 14078.788818167735, 26201.21396358112, 26313.868430657723, 26383.208503744918, 26465.338366540604, 26478.205653830417, 9553.283503737248, 9583.0, 9756.707298781048, 9772.267079969031, 9829.557669904729, 5155.149400348901, 5176.430592634807, 5203.349581302337, 5308.973455132699, 5336.146216605324, 3907.765534067965, 3992.6207010333974, 4013.799310034545, 4015.277250095011, 4022.738521996061, 625.340266019354, 630.3538872655565, 641.0992555459587, 651.7034749189107, 658.9505787065989, 850.8170743290223, 866.3675516872593, 873.3580818098692, 874.3267683883374, 881.259741816877, 11686.94156529212, 11713.414329283502, 11822.52709891612, 11963.222390544586, 12232.938835305944, 819.3117781063935, 845.526505157114, 853.8206976534997, 865.7056600755773, 874.2699845628971, 5508.889822203533, 5545.140503222007, 5613.803516876889, 5679.574031947621, 5718.399568045378, 77760.0, 78220.60889695628, 78753.60623196847, 79805.0, 83205.58397207975, 71363.64318178376, 72051.0, 73298.0, 74581.0, 75143.62428187934, 65199.67400162969, 65442.345576544576, 66055.33944660588, 66644.0, 67038.0, 10738.46307684597, 10952.288101273392, 11103.833442498208, 11244.212905096565, 11278.0, 45501.31748023716, 46314.53685463102, 46543.0, 46798.76600616975, 46838.0, 52457.21314180214, 52598.21102683539, 52969.0, 53091.0, 54328.46864953765, 13801.447942082204, 13969.231692257023, 14068.507602233873, 14113.2943352834, 14197.858021420067, 14354.210518421587, 14498.34757435939, 14835.925820371262, 15102.697946041237, 15489.225538723244, 13425.66435839112, 13867.583972480841, 13875.653108672364, 13933.0, 14150.78773818373, 10344.586216551254, 14018.929905350817, 14036.157830530201, 14126.717465650423, 14220.146791192561, 13860.722785544434, 14187.716245674823, 14339.426422943383, 14396.424143034581, 14506.492272770402, 11359.943200283946, 11413.942930285295, 11537.134714896249, 11701.2979221247, 12018.639440816789, 12174.33041182708, 12221.69445763863, 12327.93836030814, 12537.185082969578, 12927.935360323138], "value": 8022.588311112028, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1450.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 113.0, 112.0, 113.0, 114.0, 113.0, 114.0, 112.0, 112.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 116.0, 118.0, 156.0, 115.0, 118.0, 116.0, 114.0, 135.0, 116.0], "value": 124.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 163.0, 161.0, 162.0, 161.0, 161.0, 159.0, 162.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 113.0, 75.0, 75.0, 75.0, 77.0, 95.0, 75.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 102.0, 82.0, 82.0, 82.0, 100.0, 81.0, 82.0, 113.0], "value": 88.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 112.0, 115.0, 113.0, 112.0, 113.0, 112.0, 113.0, 112.0], "value": 112.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 56.0, 55.0, 54.0, 55.0, 55.0, 54.0, 55.0, 54.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 54.0, 53.0, 53.0, 53.0, 53.0, 53.0, 54.0], "value": 53.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 75.0, 87.0, 79.0, 74.0, 79.0, 82.0, 76.0, 84.0, 105.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 120.0, 124.0, 126.0, 119.0, 125.0, 116.0, 118.0, 140.0, 122.0], "value": 123.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 157.0, 156.0, 165.0, 155.0, 155.0, 161.0, 164.0, 157.0, 156.0], "value": 158.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 59.0, 60.0, 59.0, 59.0, 60.0, 59.0, 58.0, 58.0], "value": 59.5, "unit": "score"}]}]} 02:55:28 INFO - Return code: 0 02:55:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:55:28 INFO - # TBPL SUCCESS # 02:55:28 INFO - Running post-action listener: _resource_record_post_action 02:55:28 INFO - [mozharness: 2017-06-02 09:55:28.775506Z] Finished run-tests step (success) 02:55:28 INFO - Running post-run listener: _resource_record_post_run 02:55:28 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 326008832; Read time: 12; Write time: 135044 02:55:28 INFO - TinderboxPrint: CPU usage
13.1% 02:55:28 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 02:55:28 INFO - TinderboxPrint: I/O write bytes / time
326,008,832 / 135,044 02:55:28 INFO - TinderboxPrint: CPU idle
8,254.3 (86.9%) 02:55:28 INFO - TinderboxPrint: CPU user
1,198.0 (12.6%) 02:55:28 INFO - TinderboxPrint: Swap in / out
0 / 0 02:55:28 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 90431488; Read time: 0; Write time: 53520 02:55:28 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 235577344; Read time: 12; Write time: 81524 02:55:29 INFO - Running post-run listener: _upload_blobber_files 02:55:29 INFO - Blob upload gear active. 02:55:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:55:29 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 02:55:29 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'] 02:55:29 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 02:55:29 INFO - (blobuploader) - INFO - Open directory for files ... 02:55:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:55:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:55:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:55:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:55:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:55:30 INFO - (blobuploader) - INFO - Done attempting. 02:55:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:55:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:55:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:55:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:55:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:55:34 INFO - (blobuploader) - INFO - Done attempting. 02:55:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:55:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:55:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:55:35 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:55:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:55:35 INFO - (blobuploader) - INFO - Done attempting. 02:55:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:55:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:55:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:55:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:55:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:55:36 INFO - (blobuploader) - INFO - Done attempting. 02:55:36 INFO - (blobuploader) - INFO - Iteration through files over. 02:55:36 INFO - Return code: 0 02:55:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:55:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:55:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c1ceba28941114609d8a26ea1172e173aac21887ec925e92aa47eda19b739186669f07cf6c6d06cd615efdda0a1914cbdbe1d7c99aa758254b1276295c37c126", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/fcbb47d6db257607d76fa977d0af269bc3620afa6fdb55f8a4cd58c5579eb4778751da7d047aa8805dff3a3e6e5d2d6b8e2e11dbb83dd07a57e238ad66aa62d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5a37a4804e3d17090ba702fbfaf8e4548d9fc666c1442fbc45fc522a2073093f99ef9f55e1fc3f9123ef497723f525c63214b46a2076a8321ffaa8e1d3f9687b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/19b7372730507d29c7c72c7d8ad02fcca874354d4f6f75e638a031771698f2494d8c9a1a3c8ec67000adcd38292442da88fc3289964ad87eb4dbd07ff55081a4"} 02:55:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:55:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:55:36 INFO - Contents: 02:55:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c1ceba28941114609d8a26ea1172e173aac21887ec925e92aa47eda19b739186669f07cf6c6d06cd615efdda0a1914cbdbe1d7c99aa758254b1276295c37c126", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/fcbb47d6db257607d76fa977d0af269bc3620afa6fdb55f8a4cd58c5579eb4778751da7d047aa8805dff3a3e6e5d2d6b8e2e11dbb83dd07a57e238ad66aa62d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5a37a4804e3d17090ba702fbfaf8e4548d9fc666c1442fbc45fc522a2073093f99ef9f55e1fc3f9123ef497723f525c63214b46a2076a8321ffaa8e1d3f9687b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/19b7372730507d29c7c72c7d8ad02fcca874354d4f6f75e638a031771698f2494d8c9a1a3c8ec67000adcd38292442da88fc3289964ad87eb4dbd07ff55081a4"} 02:55:36 INFO - Running post-run listener: copy_logs_to_upload_dir 02:55:36 INFO - Copying logs to upload dir... 02:55:36 INFO - mkdir: /builds/slave/test/build/upload/logs 02:55:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.250946 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-06-02 02:55:34.921073) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-02 02:55:34.928291) ========= 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=4300f881736b422476174874000001bc-1496390087.186497-2089198969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c1ceba28941114609d8a26ea1172e173aac21887ec925e92aa47eda19b739186669f07cf6c6d06cd615efdda0a1914cbdbe1d7c99aa758254b1276295c37c126", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/fcbb47d6db257607d76fa977d0af269bc3620afa6fdb55f8a4cd58c5579eb4778751da7d047aa8805dff3a3e6e5d2d6b8e2e11dbb83dd07a57e238ad66aa62d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5a37a4804e3d17090ba702fbfaf8e4548d9fc666c1442fbc45fc522a2073093f99ef9f55e1fc3f9123ef497723f525c63214b46a2076a8321ffaa8e1d3f9687b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/19b7372730507d29c7c72c7d8ad02fcca874354d4f6f75e638a031771698f2494d8c9a1a3c8ec67000adcd38292442da88fc3289964ad87eb4dbd07ff55081a4"} build_url:https://queue.taskcluster.net/v1/task/fBJh4HooTRWQKp_oyHJLMA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011234 build_url: 'https://queue.taskcluster.net/v1/task/fBJh4HooTRWQKp_oyHJLMA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c1ceba28941114609d8a26ea1172e173aac21887ec925e92aa47eda19b739186669f07cf6c6d06cd615efdda0a1914cbdbe1d7c99aa758254b1276295c37c126", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/fcbb47d6db257607d76fa977d0af269bc3620afa6fdb55f8a4cd58c5579eb4778751da7d047aa8805dff3a3e6e5d2d6b8e2e11dbb83dd07a57e238ad66aa62d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5a37a4804e3d17090ba702fbfaf8e4548d9fc666c1442fbc45fc522a2073093f99ef9f55e1fc3f9123ef497723f525c63214b46a2076a8321ffaa8e1d3f9687b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/19b7372730507d29c7c72c7d8ad02fcca874354d4f6f75e638a031771698f2494d8c9a1a3c8ec67000adcd38292442da88fc3289964ad87eb4dbd07ff55081a4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-02 02:55:34.955830) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 02:55:34.956181) ========= 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=4300f881736b422476174874000001bc-1496390087.186497-2089198969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004414 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 02:55:35.036694) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-02 02:55:35.040040) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-02 02:55:35.040360) ========= ========= Total master_lag: 0.22 =========