builder: mozilla-beta_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-009 starttime: 1496912995.62 results: success (0) revision: 2125aa846c90398be9d3b6c01ff48de8265aeba3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-08 02:09:55.618583) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-08 02:09:55.618957) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-08 02:09:55.619228) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-08 02:09:55.673450) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 02:09:55.673706) ========= 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=17051fcd5208b27b50bedfeb000001dd-1496910229.93506-1865388782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-08 02:09:56-- 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% 216M=0s 2017-06-08 02:09:56 (216 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.168964 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 02:09:55.864406) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 02:09:55.864693) ========= 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=17051fcd5208b27b50bedfeb000001dd-1496910229.93506-1865388782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019751 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 02:09:55.914687) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-08 02:09:55.917991) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2125aa846c90398be9d3b6c01ff48de8265aeba3 --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 2125aa846c90398be9d3b6c01ff48de8265aeba3 --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=17051fcd5208b27b50bedfeb000001dd-1496910229.93506-1865388782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-08 02:09:56,583 truncating revision to first 12 chars 2017-06-08 02:09:56,583 Setting DEBUG logging. 2017-06-08 02:09:56,583 attempt 1/10 2017-06-08 02:09:56,583 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/2125aa846c90?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-08 02:09:57,438 unpacking tar archive at: mozilla-beta-2125aa846c90/testing/mozharness/ program finished with exit code 0 elapsedTime=1.176464 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-08 02:09:57.108477) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-08 02:09:57.108747) ========= script_repo_revision: 2125aa846c90398be9d3b6c01ff48de8265aeba3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-08 02:09:57.112158) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-08 02:09:57.112423) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-08 02:09:57.120911) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-06-08 02:09:57.121235) ========= /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=17051fcd5208b27b50bedfeb000001dd-1496910229.93506-1865388782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:09:57 INFO - MultiFileLogger online at 20170608 02:09:57 in /builds/slave/test 02:09:57 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:09:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:09:57 INFO - {'append_to_log': False, 02:09:57 INFO - 'base_work_dir': '/builds/slave/test', 02:09:57 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 02:09:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:09:57 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 02:09:57 INFO - 'buildbot_json_path': 'buildprops.json', 02:09:57 INFO - 'config_files': ('talos/linux_config.py',), 02:09:57 INFO - 'default_actions': ('clobber', 02:09:57 INFO - 'read-buildbot-config', 02:09:57 INFO - 'download-and-extract', 02:09:57 INFO - 'populate-webroot', 02:09:57 INFO - 'create-virtualenv', 02:09:57 INFO - 'install', 02:09:57 INFO - 'run-tests'), 02:09:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:09:57 INFO - 'download_minidump_stackwalk': True, 02:09:57 INFO - 'download_symbols': 'ondemand', 02:09:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:09:57 INFO - 'tooltool.py': '/tools/tooltool.py', 02:09:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:09:57 INFO - '/tools/misc-python/virtualenv.py')}, 02:09:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:09:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:09:57 INFO - 'gecko_profile': False, 02:09:57 INFO - 'gecko_profile_interval': 0, 02:09:57 INFO - 'installer_path': 'installer.exe', 02:09:57 INFO - 'log_level': 'info', 02:09:57 INFO - 'log_name': 'talos', 02:09:57 INFO - 'log_to_console': True, 02:09:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:09:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:09:57 INFO - 'opt_config_files': (), 02:09:57 INFO - 'pip_index': False, 02:09:57 INFO - 'suite': 'dromaeojs', 02:09:57 INFO - 'system_bits': '32', 02:09:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:09:57 INFO - 'title': 'talos-linux64-ix-009', 02:09:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:09:57 INFO - 'use_talos_json': True, 02:09:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:09:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:09:57 INFO - 'work_dir': 'build'} 02:09:57 INFO - [mozharness: 2017-06-08 09:09:57.882139Z] Running clobber step. 02:09:57 INFO - Running pre-action listener: _resource_record_pre_action 02:09:57 INFO - Running main action method: clobber 02:09:57 INFO - rmtree: /builds/slave/test/build 02:09:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:09:58 INFO - Running post-action listener: _resource_record_post_action 02:09:58 INFO - [mozharness: 2017-06-08 09:09:58.898954Z] Finished clobber step (success) 02:09:58 INFO - [mozharness: 2017-06-08 09:09:58.899055Z] Running read-buildbot-config step. 02:09:58 INFO - Running pre-action listener: _resource_record_pre_action 02:09:58 INFO - Running main action method: read_buildbot_config 02:09:58 INFO - Using buildbot properties: 02:09:58 INFO - { 02:09:58 INFO - "project": "", 02:09:58 INFO - "product": "firefox", 02:09:58 INFO - "who": "cbook@mozilla.com", 02:09:58 INFO - "installer_path": "public/build/target.tar.bz2", 02:09:58 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 02:09:58 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta/", 02:09:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs", 02:09:58 INFO - "stage_platform": "linux64", 02:09:58 INFO - "basedir": "/builds/slave/test", 02:09:58 INFO - "buildnumber": 59, 02:09:58 INFO - "platform": "ubuntu64_hw", 02:09:58 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:09:58 INFO - "slavebuilddir": "test", 02:09:58 INFO - "taskId": "XGNlFkqmRHSGgCC6BQvsNA", 02:09:58 INFO - "branch": "mozilla-beta", 02:09:58 INFO - "script_repo_revision": "production", 02:09:58 INFO - "revision": "2125aa846c90398be9d3b6c01ff48de8265aeba3", 02:09:58 INFO - "slavename": "talos-linux64-ix-009", 02:09:58 INFO - "repo_path": "releases/mozilla-beta" 02:09:58 INFO - } 02:09:58 INFO - Finding installer, test and symbols from parent task. 02:09:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XGNlFkqmRHSGgCC6BQvsNA'}, attempt #1 02:09:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XGNlFkqmRHSGgCC6BQvsNA'}, attempt #1 02:09:59 INFO - Task dependencies: ayb1ueBDQpiGE29cznG40w 02:09:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ayb1ueBDQpiGE29cznG40w'}, attempt #1 02:10:00 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ayb1ueBDQpiGE29cznG40w/artifacts/public/build/target.tar.bz2 02:10:00 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ayb1ueBDQpiGE29cznG40w/artifacts/public/build/test_packages.json 02:10:00 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ayb1ueBDQpiGE29cznG40w/artifacts/public/build/target.crashreporter-symbols.zip 02:10:00 INFO - Running post-action listener: _resource_record_post_action 02:10:00 INFO - [mozharness: 2017-06-08 09:10:00.261269Z] Finished read-buildbot-config step (success) 02:10:00 INFO - [mozharness: 2017-06-08 09:10:00.261489Z] Running download-and-extract step. 02:10:00 INFO - Running pre-action listener: _resource_record_pre_action 02:10:00 INFO - Running main action method: download_and_extract 02:10:00 INFO - mkdir: /builds/slave/test/build/tests 02:10:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:00 INFO - trying https://queue.taskcluster.net/v1/task/ayb1ueBDQpiGE29cznG40w/artifacts/public/build/target.test_packages.json 02:10:00 INFO - Downloading https://queue.taskcluster.net/v1/task/ayb1ueBDQpiGE29cznG40w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:10:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ayb1ueBDQpiGE29cznG40w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:10:00 INFO - Downloaded 986 bytes. 02:10:00 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:10:00 INFO - Using the following test package requirements: 02:10:00 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:10:00 INFO - u'common': [u'target.common.tests.zip'], 02:10:00 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:10:00 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:10:00 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:10:00 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:10:00 INFO - u'mozbase': [u'target.common.tests.zip'], 02:10:00 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:10:00 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:10:00 INFO - u'web-platform': [u'target.common.tests.zip', 02:10:00 INFO - u'target.web-platform.tests.zip'], 02:10:00 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:10:00 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:10:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ayb1ueBDQpiGE29cznG40w/artifacts/public/build/target.common.tests.zip 02:10:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ayb1ueBDQpiGE29cznG40w/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:10:00 INFO - Fetch https://queue.taskcluster.net/v1/task/ayb1ueBDQpiGE29cznG40w/artifacts/public/build/target.common.tests.zip into memory 02:10:01 INFO - Expected file size: 59713379 02:10:01 INFO - Obtained file size: 59713379 02:10:11 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:10:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ayb1ueBDQpiGE29cznG40w/artifacts/public/build/target.common.tests.zip 02:10:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ayb1ueBDQpiGE29cznG40w/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:10:11 INFO - Fetch https://queue.taskcluster.net/v1/task/ayb1ueBDQpiGE29cznG40w/artifacts/public/build/target.common.tests.zip into memory 02:10:12 INFO - Expected file size: 59713379 02:10:12 INFO - Obtained file size: 59713379 02:10:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ayb1ueBDQpiGE29cznG40w/artifacts/public/build/target.talos.tests.zip 02:10:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ayb1ueBDQpiGE29cznG40w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:10:23 INFO - Fetch https://queue.taskcluster.net/v1/task/ayb1ueBDQpiGE29cznG40w/artifacts/public/build/target.talos.tests.zip into memory 02:10:24 INFO - Expected file size: 14404461 02:10:24 INFO - Obtained file size: 14404461 02:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:24 INFO - trying https://queue.taskcluster.net/v1/task/ayb1ueBDQpiGE29cznG40w/artifacts/public/build/target.tar.bz2 02:10:24 INFO - Downloading https://queue.taskcluster.net/v1/task/ayb1ueBDQpiGE29cznG40w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:10:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ayb1ueBDQpiGE29cznG40w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:10:25 INFO - Downloaded 59822621 bytes. 02:10:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ayb1ueBDQpiGE29cznG40w/artifacts/public/build/target.tar.bz2 02:10:25 INFO - mkdir: /builds/slave/test/properties 02:10:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:10:25 INFO - Writing to file /builds/slave/test/properties/build_url 02:10:25 INFO - Contents: 02:10:25 INFO - build_url:https://queue.taskcluster.net/v1/task/ayb1ueBDQpiGE29cznG40w/artifacts/public/build/target.tar.bz2 02:10:25 INFO - Running post-action listener: _resource_record_post_action 02:10:25 INFO - Running post-action listener: set_extra_try_arguments 02:10:25 INFO - [mozharness: 2017-06-08 09:10:25.399571Z] Finished download-and-extract step (success) 02:10:25 INFO - [mozharness: 2017-06-08 09:10:25.399667Z] Running populate-webroot step. 02:10:25 INFO - Running pre-action listener: _resource_record_pre_action 02:10:25 INFO - Running main action method: populate_webroot 02:10:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:10:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:10:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:10:25 INFO - '--tppagecycles', 02:10:25 INFO - '7'], 02:10:25 INFO - 'tests': ['tsvgm']}}, 02:10:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:10:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:10:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:10:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:10:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:10:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:10:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:10:25 INFO - 'talos_options': ['--disable-e10s'], 02:10:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:10:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:10:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:10:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:10:25 INFO - 'talos_options': ['--disable-e10s'], 02:10:25 INFO - 'tests': ['damp', 'tps']}, 02:10:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:10:25 INFO - 'tests': ['damp', 'tps']}, 02:10:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:10:25 INFO - 'tests': ['dromaeo_dom']}, 02:10:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:10:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:10:25 INFO - 'tests': ['basic_compositor_video']}, 02:10:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:10:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:10:25 INFO - 'tests': ['a11yr', 02:10:25 INFO - 'ts_paint', 02:10:25 INFO - 'tpaint', 02:10:25 INFO - 'sessionrestore', 02:10:25 INFO - 'sessionrestore_no_auto_restore', 02:10:25 INFO - 'tabpaint']}, 02:10:25 INFO - 'other-e10s': {'tests': ['a11yr', 02:10:25 INFO - 'ts_paint', 02:10:25 INFO - 'tpaint', 02:10:25 INFO - 'sessionrestore', 02:10:25 INFO - 'sessionrestore_no_auto_restore', 02:10:25 INFO - 'tabpaint']}, 02:10:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:10:25 INFO - 'ts_paint', 02:10:25 INFO - 'tpaint', 02:10:25 INFO - 'sessionrestore', 02:10:25 INFO - 'sessionrestore_no_auto_restore', 02:10:25 INFO - 'tabpaint']}, 02:10:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:10:25 INFO - 'ts_paint', 02:10:25 INFO - 'tpaint', 02:10:25 INFO - 'sessionrestore', 02:10:25 INFO - 'sessionrestore_no_auto_restore', 02:10:25 INFO - 'tabpaint']}, 02:10:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:10:25 INFO - 'tests': ['a11yr', 02:10:25 INFO - 'ts_paint', 02:10:25 INFO - 'tpaint', 02:10:25 INFO - 'sessionrestore', 02:10:25 INFO - 'sessionrestore_no_auto_restore', 02:10:25 INFO - 'tabpaint']}, 02:10:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:10:25 INFO - 'tests': ['a11yr', 02:10:25 INFO - 'ts_paint', 02:10:25 INFO - 'tpaint', 02:10:25 INFO - 'sessionrestore', 02:10:25 INFO - 'sessionrestore_no_auto_restore', 02:10:25 INFO - 'tabpaint']}, 02:10:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:10:25 INFO - 'tests': ['tsvgx', 02:10:25 INFO - 'tsvgr_opacity', 02:10:25 INFO - 'tart', 02:10:25 INFO - 'tscrollx', 02:10:25 INFO - 'cart', 02:10:25 INFO - 'tsvg_static']}, 02:10:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:10:25 INFO - 'tsvgr_opacity', 02:10:25 INFO - 'tart', 02:10:25 INFO - 'tscrollx', 02:10:25 INFO - 'cart', 02:10:25 INFO - 'tsvg_static']}, 02:10:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:10:25 INFO - 'talos_options': ['--disable-e10s'], 02:10:25 INFO - 'tests': ['tp5o']}, 02:10:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:10:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:10:25 INFO - 'talos_options': ['--disable-e10s', 02:10:25 INFO - '--xperf_path', 02:10:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:10:25 INFO - 'tests': ['tp5n']}, 02:10:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:10:25 INFO - 'talos_options': ['--xperf_path', 02:10:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:10:25 INFO - 'tests': ['tp5n']}}, 02:10:25 INFO - 'talos.zip': {'path': '', 02:10:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:10:25 INFO - Running post-action listener: _resource_record_post_action 02:10:25 INFO - [mozharness: 2017-06-08 09:10:25.412779Z] Finished populate-webroot step (success) 02:10:25 INFO - [mozharness: 2017-06-08 09:10:25.412869Z] Running create-virtualenv step. 02:10:25 INFO - Running pre-action listener: _resource_record_pre_action 02:10:25 INFO - Running main action method: create_virtualenv 02:10:25 INFO - Creating virtualenv /builds/slave/test/build/venv 02:10:25 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:10:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:10:25 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:10:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:10:25 INFO - Using real prefix '/usr' 02:10:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:10:26 INFO - Installing distribute.............................................................................................................................................................................................done. 02:10:27 INFO - Installing pip.................done. 02:10:27 INFO - Return code: 0 02:10:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:10:28 INFO - Reading from file tmpfile_stdout 02:10:28 INFO - Output received: 02:10:28 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:10:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:10: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:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10: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:10:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1647a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a7310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a4400>, '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 0x18a53b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a5840>, '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': '17051fcd5208b27b50bedfeb000001dd-1496910229.93506-1865388782', '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:10: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', 'pip>=1.5'] in /builds/slave/test/build 02:10: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 pip>=1.5 02:10:28 INFO - Using env: {'DISPLAY': ':0', 02:10:28 INFO - 'HOME': '/home/cltbld', 02:10:28 INFO - 'LANG': 'en_US.UTF-8', 02:10:28 INFO - 'LANGUAGE': 'en_US:en', 02:10:28 INFO - 'LOGNAME': 'cltbld', 02:10:28 INFO - 'MAIL': '/var/mail/cltbld', 02:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:28 INFO - 'MOZ_NO_REMOTE': '1', 02:10:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:28 INFO - 'NO_EM_RESTART': '1', 02:10:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:28 INFO - 'PWD': '/builds/slave/test', 02:10:28 INFO - 'SHELL': '/bin/bash', 02:10:28 INFO - 'SHLVL': '1', 02:10:28 INFO - 'TERM': 'linux', 02:10:28 INFO - 'TMOUT': '86400', 02:10:28 INFO - 'USER': 'cltbld', 02:10:28 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1496910229.93506-1865388782', 02:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:28 INFO - '_': '/tools/buildbot/bin/python'} 02:10:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:28 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:10:28 INFO - Cleaning up... 02:10:28 INFO - Return code: 0 02:10:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:10: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:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10: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:10:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10: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', '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 0x16091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1647a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a7310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a4400>, '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 0x18a53b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a5840>, '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': '17051fcd5208b27b50bedfeb000001dd-1496910229.93506-1865388782', '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:10: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', 'psutil>=3.1.1'] in /builds/slave/test/build 02:10: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 psutil>=3.1.1 02:10:28 INFO - Using env: {'DISPLAY': ':0', 02:10:28 INFO - 'HOME': '/home/cltbld', 02:10:28 INFO - 'LANG': 'en_US.UTF-8', 02:10:28 INFO - 'LANGUAGE': 'en_US:en', 02:10:28 INFO - 'LOGNAME': 'cltbld', 02:10:28 INFO - 'MAIL': '/var/mail/cltbld', 02:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:28 INFO - 'MOZ_NO_REMOTE': '1', 02:10:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:28 INFO - 'NO_EM_RESTART': '1', 02:10:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:28 INFO - 'PWD': '/builds/slave/test', 02:10:28 INFO - 'SHELL': '/bin/bash', 02:10:28 INFO - 'SHLVL': '1', 02:10:28 INFO - 'TERM': 'linux', 02:10:28 INFO - 'TMOUT': '86400', 02:10:28 INFO - 'USER': 'cltbld', 02:10:28 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1496910229.93506-1865388782', 02:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:28 INFO - '_': '/tools/buildbot/bin/python'} 02:10:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:28 INFO - Downloading/unpacking psutil>=3.1.1 02:10: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:10: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:10: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:10: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:10:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:10:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:10:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:10:29 INFO - Installing collected packages: psutil 02:10:29 INFO - Running setup.py install for psutil 02:10:29 INFO - building 'psutil._psutil_linux' extension 02:10:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:10:30 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:10:30 INFO - building 'psutil._psutil_posix' extension 02:10:30 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:10:30 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:10:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:10:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:10:30 INFO - Successfully installed psutil 02:10:30 INFO - Cleaning up... 02:10:30 INFO - Return code: 0 02:10:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:10:30 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:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:30 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:10:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:30 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 0x16091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1647a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a7310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a4400>, '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 0x18a53b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a5840>, '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': '17051fcd5208b27b50bedfeb000001dd-1496910229.93506-1865388782', '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:10:30 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:10:30 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:10:30 INFO - Using env: {'DISPLAY': ':0', 02:10:30 INFO - 'HOME': '/home/cltbld', 02:10:30 INFO - 'LANG': 'en_US.UTF-8', 02:10:30 INFO - 'LANGUAGE': 'en_US:en', 02:10:30 INFO - 'LOGNAME': 'cltbld', 02:10:30 INFO - 'MAIL': '/var/mail/cltbld', 02:10:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:30 INFO - 'MOZ_NO_REMOTE': '1', 02:10:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:30 INFO - 'NO_EM_RESTART': '1', 02:10:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:30 INFO - 'PWD': '/builds/slave/test', 02:10:30 INFO - 'SHELL': '/bin/bash', 02:10:30 INFO - 'SHLVL': '1', 02:10:30 INFO - 'TERM': 'linux', 02:10:30 INFO - 'TMOUT': '86400', 02:10:30 INFO - 'USER': 'cltbld', 02:10:30 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1496910229.93506-1865388782', 02:10:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:30 INFO - '_': '/tools/buildbot/bin/python'} 02:10:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:10: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:10: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:10: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:10: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:10:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:10:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:10:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:10:31 INFO - Installing collected packages: mozsystemmonitor 02:10:31 INFO - Running setup.py install for mozsystemmonitor 02:10:31 INFO - Successfully installed mozsystemmonitor 02:10:31 INFO - Cleaning up... 02:10:31 INFO - Return code: 0 02:10:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:10: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:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10: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:10:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1647a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a7310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a4400>, '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 0x18a53b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a5840>, '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': '17051fcd5208b27b50bedfeb000001dd-1496910229.93506-1865388782', '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:10:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:10:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:10:31 INFO - Using env: {'DISPLAY': ':0', 02:10:31 INFO - 'HOME': '/home/cltbld', 02:10:31 INFO - 'LANG': 'en_US.UTF-8', 02:10:31 INFO - 'LANGUAGE': 'en_US:en', 02:10:31 INFO - 'LOGNAME': 'cltbld', 02:10:31 INFO - 'MAIL': '/var/mail/cltbld', 02:10:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:31 INFO - 'MOZ_NO_REMOTE': '1', 02:10:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:31 INFO - 'NO_EM_RESTART': '1', 02:10:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:31 INFO - 'PWD': '/builds/slave/test', 02:10:31 INFO - 'SHELL': '/bin/bash', 02:10:31 INFO - 'SHLVL': '1', 02:10:31 INFO - 'TERM': 'linux', 02:10:31 INFO - 'TMOUT': '86400', 02:10:31 INFO - 'USER': 'cltbld', 02:10:31 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1496910229.93506-1865388782', 02:10:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:31 INFO - '_': '/tools/buildbot/bin/python'} 02:10:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:32 INFO - Downloading/unpacking jsonschema==2.5.1 02:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:10:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:33 INFO - Downloading functools32-3.2.3-2.tar.gz 02:10:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:10:33 INFO - warning: no files found matching '*.txt' 02:10:33 INFO - no previously-included directories found matching 'build' 02:10:33 INFO - no previously-included directories found matching 'dist' 02:10:33 INFO - no previously-included directories found matching '.git*' 02:10:33 INFO - Installing collected packages: jsonschema, functools32 02:10:33 INFO - Running setup.py install for functools32 02:10:33 INFO - warning: no files found matching '*.txt' 02:10:33 INFO - no previously-included directories found matching 'build' 02:10:33 INFO - no previously-included directories found matching 'dist' 02:10:33 INFO - no previously-included directories found matching '.git*' 02:10:33 INFO - Successfully installed jsonschema functools32 02:10:33 INFO - Cleaning up... 02:10:33 INFO - Return code: 0 02:10:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x16091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1647a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a7310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a4400>, '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 0x18a53b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a5840>, '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': '17051fcd5208b27b50bedfeb000001dd-1496910229.93506-1865388782', '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:10:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:10:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:10:33 INFO - Using env: {'DISPLAY': ':0', 02:10:33 INFO - 'HOME': '/home/cltbld', 02:10:33 INFO - 'LANG': 'en_US.UTF-8', 02:10:33 INFO - 'LANGUAGE': 'en_US:en', 02:10:33 INFO - 'LOGNAME': 'cltbld', 02:10:33 INFO - 'MAIL': '/var/mail/cltbld', 02:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:33 INFO - 'MOZ_NO_REMOTE': '1', 02:10:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:33 INFO - 'NO_EM_RESTART': '1', 02:10:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:33 INFO - 'PWD': '/builds/slave/test', 02:10:33 INFO - 'SHELL': '/bin/bash', 02:10:33 INFO - 'SHLVL': '1', 02:10:33 INFO - 'TERM': 'linux', 02:10:33 INFO - 'TMOUT': '86400', 02:10:33 INFO - 'USER': 'cltbld', 02:10:33 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1496910229.93506-1865388782', 02:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:33 INFO - '_': '/tools/buildbot/bin/python'} 02:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:10:33 INFO - Cleaning up... 02:10:33 INFO - Return code: 0 02:10:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1647a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a7310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a4400>, '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 0x18a53b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a5840>, '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': '17051fcd5208b27b50bedfeb000001dd-1496910229.93506-1865388782', '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:10:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:10:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:10:33 INFO - Using env: {'DISPLAY': ':0', 02:10:33 INFO - 'HOME': '/home/cltbld', 02:10:33 INFO - 'LANG': 'en_US.UTF-8', 02:10:33 INFO - 'LANGUAGE': 'en_US:en', 02:10:33 INFO - 'LOGNAME': 'cltbld', 02:10:33 INFO - 'MAIL': '/var/mail/cltbld', 02:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:33 INFO - 'MOZ_NO_REMOTE': '1', 02:10:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:33 INFO - 'NO_EM_RESTART': '1', 02:10:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:33 INFO - 'PWD': '/builds/slave/test', 02:10:33 INFO - 'SHELL': '/bin/bash', 02:10:33 INFO - 'SHLVL': '1', 02:10:33 INFO - 'TERM': 'linux', 02:10:33 INFO - 'TMOUT': '86400', 02:10:33 INFO - 'USER': 'cltbld', 02:10:33 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1496910229.93506-1865388782', 02:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:33 INFO - '_': '/tools/buildbot/bin/python'} 02:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:33 INFO - Downloading/unpacking blobuploader==1.2.4 02:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:35 INFO - Downloading blobuploader-1.2.4.tar.gz 02:10:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:10:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:10: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:10: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:10: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:10: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:10:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:10:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:10: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:10: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:10: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:10: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:10:35 INFO - Downloading docopt-0.6.1.tar.gz 02:10:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:10:35 INFO - Installing collected packages: blobuploader, requests, docopt 02:10:35 INFO - Running setup.py install for blobuploader 02:10:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:10:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:10:35 INFO - Running setup.py install for requests 02:10:36 INFO - Running setup.py install for docopt 02:10:36 INFO - Successfully installed blobuploader requests docopt 02:10:36 INFO - Cleaning up... 02:10:36 INFO - Return code: 0 02:10:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:10:36 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:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:36 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:10:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:36 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 0x16091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1647a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a7310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a4400>, '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 0x18a53b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a5840>, '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': '17051fcd5208b27b50bedfeb000001dd-1496910229.93506-1865388782', '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:10:36 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:10:36 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:10:36 INFO - Using env: {'DISPLAY': ':0', 02:10:36 INFO - 'HOME': '/home/cltbld', 02:10:36 INFO - 'LANG': 'en_US.UTF-8', 02:10:36 INFO - 'LANGUAGE': 'en_US:en', 02:10:36 INFO - 'LOGNAME': 'cltbld', 02:10:36 INFO - 'MAIL': '/var/mail/cltbld', 02:10:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:36 INFO - 'MOZ_NO_REMOTE': '1', 02:10:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:36 INFO - 'NO_EM_RESTART': '1', 02:10:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:36 INFO - 'PWD': '/builds/slave/test', 02:10:36 INFO - 'SHELL': '/bin/bash', 02:10:36 INFO - 'SHLVL': '1', 02:10:36 INFO - 'TERM': 'linux', 02:10:36 INFO - 'TMOUT': '86400', 02:10:36 INFO - 'USER': 'cltbld', 02:10:36 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1496910229.93506-1865388782', 02:10:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:36 INFO - '_': '/tools/buildbot/bin/python'} 02:10:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:10:36 INFO - Running setup.py (path:/tmp/pip-l5Q6iq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:10:36 INFO - Running setup.py (path:/tmp/pip-i8diYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:10:36 INFO - Running setup.py (path:/tmp/pip-nABALw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:10:36 INFO - Running setup.py (path:/tmp/pip-cFDLGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:10:36 INFO - Running setup.py (path:/tmp/pip-JJe5nT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:10:36 INFO - Running setup.py (path:/tmp/pip-CeUSF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:10:36 INFO - Running setup.py (path:/tmp/pip-aHqW03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:10:36 INFO - Running setup.py (path:/tmp/pip-OSLq4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:10:37 INFO - Running setup.py (path:/tmp/pip-58I8x3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:10:37 INFO - Running setup.py (path:/tmp/pip-cP7kyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:10:37 INFO - Running setup.py (path:/tmp/pip-Phx4xN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:10:37 INFO - Running setup.py (path:/tmp/pip-cAcVl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:10:37 INFO - Running setup.py (path:/tmp/pip-8oww47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:10:37 INFO - Running setup.py (path:/tmp/pip-OKSOQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:37 INFO - Running setup.py (path:/tmp/pip-9ZJhLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:10:37 INFO - Running setup.py (path:/tmp/pip-t2abA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:10:37 INFO - Running setup.py (path:/tmp/pip-op7oGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:10:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:10:37 INFO - Running setup.py install for manifestparser 02:10:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:10:37 INFO - Running setup.py install for mozcrash 02:10:37 INFO - Running setup.py install for mozdebug 02:10:37 INFO - Running setup.py install for mozdevice 02:10:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:10:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:10:38 INFO - Running setup.py install for mozfile 02:10:38 INFO - Running setup.py install for mozhttpd 02:10:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:10:38 INFO - Running setup.py install for mozinfo 02:10:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:10:38 INFO - Running setup.py install for mozInstall 02:10:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:10:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:10:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:10:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:10:38 INFO - Running setup.py install for mozleak 02:10:38 INFO - Running setup.py install for mozlog 02:10:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:10:38 INFO - Running setup.py install for moznetwork 02:10:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:10:38 INFO - Running setup.py install for mozprocess 02:10:38 INFO - Running setup.py install for mozprofile 02:10:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:10:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:10:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:10:39 INFO - Running setup.py install for mozrunner 02:10:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:10:39 INFO - Running setup.py install for mozscreenshot 02:10:39 INFO - Running setup.py install for moztest 02:10:39 INFO - Running setup.py install for mozversion 02:10:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:10:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:10:39 INFO - Cleaning up... 02:10:39 INFO - Return code: 0 02:10:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:10:39 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:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:39 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:10:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:39 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 0x16091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1647a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a7310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a4400>, '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 0x18a53b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a5840>, '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': '17051fcd5208b27b50bedfeb000001dd-1496910229.93506-1865388782', '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:10:39 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:10:39 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:10:39 INFO - Using env: {'DISPLAY': ':0', 02:10:39 INFO - 'HOME': '/home/cltbld', 02:10:39 INFO - 'LANG': 'en_US.UTF-8', 02:10:39 INFO - 'LANGUAGE': 'en_US:en', 02:10:39 INFO - 'LOGNAME': 'cltbld', 02:10:39 INFO - 'MAIL': '/var/mail/cltbld', 02:10:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:39 INFO - 'MOZ_NO_REMOTE': '1', 02:10:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:39 INFO - 'NO_EM_RESTART': '1', 02:10:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:39 INFO - 'PWD': '/builds/slave/test', 02:10:39 INFO - 'SHELL': '/bin/bash', 02:10:39 INFO - 'SHLVL': '1', 02:10:39 INFO - 'TERM': 'linux', 02:10:39 INFO - 'TMOUT': '86400', 02:10:39 INFO - 'USER': 'cltbld', 02:10:39 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1496910229.93506-1865388782', 02:10:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:39 INFO - '_': '/tools/buildbot/bin/python'} 02:10:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:10:39 INFO - Running setup.py (path:/tmp/pip-wDc4k3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:10:39 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:10:39 INFO - Running setup.py (path:/tmp/pip-k8Rzc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:10:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:10:39 INFO - Running setup.py (path:/tmp/pip-a8tTZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:10:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:10:39 INFO - Running setup.py (path:/tmp/pip-1xe77A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:10:40 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:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:10:40 INFO - Running setup.py (path:/tmp/pip-8ASmPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:10:40 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:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:10:40 INFO - Running setup.py (path:/tmp/pip-ujbn6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:10:40 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:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:10:40 INFO - Running setup.py (path:/tmp/pip-X9sDpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:10:40 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:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:10:40 INFO - Running setup.py (path:/tmp/pip-kEqqBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:10:40 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:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:10:40 INFO - Running setup.py (path:/tmp/pip-AJYaRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:10:40 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:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:10:40 INFO - Running setup.py (path:/tmp/pip-Px7tu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:10:40 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:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:10:40 INFO - Running setup.py (path:/tmp/pip-Uztv5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:10:40 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:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:10:40 INFO - Running setup.py (path:/tmp/pip-nhpkOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:10:40 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:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:10:40 INFO - Running setup.py (path:/tmp/pip-fgKWYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:10:40 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:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:10:40 INFO - Running setup.py (path:/tmp/pip-8KZRSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:10:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:40 INFO - Running setup.py (path:/tmp/pip-jnVDCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:10:40 INFO - Running setup.py (path:/tmp/pip-Lp1HXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:10:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:10:40 INFO - Running setup.py (path:/tmp/pip-ffHfYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:10:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:10:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:10:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:10:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:10:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:10:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:10:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:42 INFO - Downloading blessings-1.6.tar.gz 02:10:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:10:42 INFO - Installing collected packages: blessings 02:10:42 INFO - Running setup.py install for blessings 02:10:42 INFO - Successfully installed blessings 02:10:42 INFO - Cleaning up... 02:10:42 INFO - Return code: 0 02:10:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:10:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:10:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:10:42 INFO - Reading from file tmpfile_stdout 02:10:42 INFO - Current package versions: 02:10:42 INFO - argparse == 1.2.1 02:10:42 INFO - blessings == 1.6 02:10:42 INFO - blobuploader == 1.2.4 02:10:42 INFO - docopt == 0.6.1 02:10:42 INFO - functools32 == 3.2.3-2 02:10:42 INFO - jsonschema == 2.5.1 02:10:42 INFO - manifestparser == 1.1 02:10:42 INFO - mozInstall == 1.12 02:10:42 INFO - mozcrash == 1.0 02:10:42 INFO - mozdebug == 0.1 02:10:42 INFO - mozdevice == 0.49 02:10:42 INFO - mozfile == 1.2 02:10:42 INFO - mozhttpd == 0.7 02:10:42 INFO - mozinfo == 0.9 02:10:42 INFO - mozleak == 0.1 02:10:42 INFO - mozlog == 3.4 02:10:42 INFO - moznetwork == 0.27 02:10:42 INFO - mozprocess == 0.25 02:10:42 INFO - mozprofile == 0.28 02:10:42 INFO - mozrunner == 6.13 02:10:42 INFO - mozscreenshot == 0.1 02:10:42 INFO - mozsystemmonitor == 0.3 02:10:42 INFO - moztest == 0.8 02:10:42 INFO - mozversion == 1.4 02:10:42 INFO - psutil == 3.1.1 02:10:42 INFO - requests == 1.2.3 02:10:42 INFO - wsgiref == 0.1.2 02:10:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:10:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:42 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 0x16091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1647a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a7310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a4400>, '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 0x18a53b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a5840>, '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': '17051fcd5208b27b50bedfeb000001dd-1496910229.93506-1865388782', '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:10:42 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:10:42 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:10:42 INFO - Using env: {'DISPLAY': ':0', 02:10:42 INFO - 'HOME': '/home/cltbld', 02:10:42 INFO - 'LANG': 'en_US.UTF-8', 02:10:42 INFO - 'LANGUAGE': 'en_US:en', 02:10:42 INFO - 'LOGNAME': 'cltbld', 02:10:42 INFO - 'MAIL': '/var/mail/cltbld', 02:10:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:42 INFO - 'MOZ_NO_REMOTE': '1', 02:10:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:42 INFO - 'NO_EM_RESTART': '1', 02:10:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:42 INFO - 'PWD': '/builds/slave/test', 02:10:42 INFO - 'SHELL': '/bin/bash', 02:10:42 INFO - 'SHLVL': '1', 02:10:42 INFO - 'TERM': 'linux', 02:10:42 INFO - 'TMOUT': '86400', 02:10:42 INFO - 'USER': 'cltbld', 02:10:42 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1496910229.93506-1865388782', 02:10:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:42 INFO - '_': '/tools/buildbot/bin/python'} 02:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:10:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:10:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:10:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:10:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:10:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:10:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:10:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:10:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:10:42 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:10:42 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:10:42 INFO - Cleaning up... 02:10:42 INFO - Return code: 0 02:10:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:10:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:42 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 0x16091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1647a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a7310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a4400>, '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 0x18a53b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a5840>, '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': '17051fcd5208b27b50bedfeb000001dd-1496910229.93506-1865388782', '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:10:42 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:10:42 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:10:42 INFO - Using env: {'DISPLAY': ':0', 02:10:42 INFO - 'HOME': '/home/cltbld', 02:10:42 INFO - 'LANG': 'en_US.UTF-8', 02:10:42 INFO - 'LANGUAGE': 'en_US:en', 02:10:42 INFO - 'LOGNAME': 'cltbld', 02:10:42 INFO - 'MAIL': '/var/mail/cltbld', 02:10:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:42 INFO - 'MOZ_NO_REMOTE': '1', 02:10:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:42 INFO - 'NO_EM_RESTART': '1', 02:10:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:42 INFO - 'PWD': '/builds/slave/test', 02:10:42 INFO - 'SHELL': '/bin/bash', 02:10:42 INFO - 'SHLVL': '1', 02:10:42 INFO - 'TERM': 'linux', 02:10:42 INFO - 'TMOUT': '86400', 02:10:42 INFO - 'USER': 'cltbld', 02:10:42 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1496910229.93506-1865388782', 02:10:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:42 INFO - '_': '/tools/buildbot/bin/python'} 02:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:10:42 INFO - Cleaning up... 02:10:42 INFO - Return code: 0 02:10:42 INFO - Running post-action listener: _resource_record_post_action 02:10:42 INFO - Running post-action listener: _start_resource_monitoring 02:10:42 INFO - Starting resource monitoring. 02:10:42 INFO - [mozharness: 2017-06-08 09:10:42.975047Z] Finished create-virtualenv step (success) 02:10:42 INFO - [mozharness: 2017-06-08 09:10:42.975517Z] Running install step. 02:10:42 INFO - Running pre-action listener: _resource_record_pre_action 02:10:42 INFO - Running main action method: install 02:10:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:10:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:10:43 INFO - Reading from file tmpfile_stdout 02:10:43 INFO - Detecting whether we're running mozinstall >=1.0... 02:10:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:10:43 INFO - Reading from file tmpfile_stdout 02:10:43 INFO - Output received: 02:10:43 INFO - Usage: mozinstall [options] installer 02:10:43 INFO - Options: 02:10:43 INFO - -h, --help show this help message and exit 02:10:43 INFO - -d DEST, --destination=DEST 02:10:43 INFO - Directory to install application into. [default: 02:10:43 INFO - "/builds/slave/test"] 02:10:43 INFO - --app=APP Application being installed. [default: firefox] 02:10:43 INFO - mkdir: /builds/slave/test/build/application 02:10:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:10:57 INFO - Reading from file tmpfile_stdout 02:10:57 INFO - Output received: 02:10:57 INFO - /builds/slave/test/build/application/firefox/firefox 02:10:57 INFO - Running post-action listener: _resource_record_post_action 02:10:57 INFO - [mozharness: 2017-06-08 09:10:57.418354Z] Finished install step (success) 02:10:57 INFO - [mozharness: 2017-06-08 09:10:57.418596Z] Running run-tests step. 02:10:57 INFO - Running pre-action listener: _resource_record_pre_action 02:10:57 INFO - Running main action method: run_tests 02:10:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:10:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:10:57 INFO - Python 2.7.3 02:10:57 INFO - Return code: 0 02:10:57 INFO - grabbing minidump binary from tooltool 02:10:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:57 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 0x18a4400>, '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 0x18a53b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a5840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:10:57 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:10:57 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:10:57 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:10:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:10:57 INFO - Return code: 0 02:10:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:10:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:10:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:10:57 INFO - ENV: RUST_BACKTRACE is now 1 02:10:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:10:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:10:57 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/ayb1ueBDQpiGE29cznG40w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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:10:57 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/ayb1ueBDQpiGE29cznG40w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-009 --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:10:57 INFO - Using env: {'DISPLAY': ':0', 02:10:57 INFO - 'HOME': '/home/cltbld', 02:10:57 INFO - 'LANG': 'en_US.UTF-8', 02:10:57 INFO - 'LANGUAGE': 'en_US:en', 02:10:57 INFO - 'LOGNAME': 'cltbld', 02:10:57 INFO - 'MAIL': '/var/mail/cltbld', 02:10:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:10:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:10:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:57 INFO - 'MOZ_NO_REMOTE': '1', 02:10:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:10:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:57 INFO - 'NO_EM_RESTART': '1', 02:10:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:57 INFO - 'PWD': '/builds/slave/test', 02:10:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:10:57 INFO - 'RUST_BACKTRACE': '1', 02:10:57 INFO - 'SHELL': '/bin/bash', 02:10:57 INFO - 'SHLVL': '1', 02:10:57 INFO - 'TERM': 'linux', 02:10:57 INFO - 'TMOUT': '86400', 02:10:57 INFO - 'USER': 'cltbld', 02:10:57 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1496910229.93506-1865388782', 02:10:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:57 INFO - '_': '/tools/buildbot/bin/python'} 02:10:57 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/ayb1ueBDQpiGE29cznG40w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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:10:57 INFO - mozversion application_buildid: 20170608081513 02:10:57 INFO - mozversion application_changeset: 2125aa846c90398be9d3b6c01ff48de8265aeba3 02:10:57 INFO - mozversion application_display_name: Firefox 02:10:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:10:57 INFO - mozversion application_name: Firefox 02:10:57 INFO - mozversion application_remotingname: firefox 02:10:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 02:10:57 INFO - mozversion application_vendor: Mozilla 02:10:57 INFO - mozversion application_version: 54.0 02:10:57 INFO - mozversion platform_buildid: 20170608081513 02:10:57 INFO - mozversion platform_changeset: 2125aa846c90398be9d3b6c01ff48de8265aeba3 02:10:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 02:10:57 INFO - mozversion platform_version: 54.0 02:10:57 INFO - using testdate: 1496913057 02:10:57 INFO - actual date: 1496913057 02:10:57 INFO - starting webserver on 'localhost:37783' 02:10:57 INFO - SUITE-START | Running 2 tests 02:10:57 INFO - TEST-START | dromaeo_css 02:10:57 INFO - operating with platform_type : linux_ 02:10:57 INFO - Initialising browser for dromaeo_css test... 02:10:57 INFO - TEST-INFO | started process 7739 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfzSj6d/profile http://localhost:37783/getInfo.html) 02:11:01 INFO - PROCESS | 7739 | __metrics Screen width/height:1600/1200 02:11:01 INFO - PROCESS | 7739 | colorDepth:24 02:11:01 INFO - PROCESS | 7739 | Browser inner width/height: 1024/697 02:11:01 INFO - PROCESS | 7739 | __metrics 02:11:02 INFO - PROCESS | 7739 | 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:11:02 INFO - PROCESS | 7739 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:11:03 INFO - PROCESS | 7739 | console.error: PushService: 02:11:03 INFO - PROCESS | 7739 | stateChangeProcessEnqueue: Error transitioning state 02:11:03 INFO - PROCESS | 7739 | UnknownError 02:11:03 INFO - TEST-INFO | 7739: exit 0 02:11:03 INFO - Browser initialized. 02:11:03 INFO - Running cycle 1/1 for dromaeo_css test... 02:11:03 INFO - TEST-INFO | started process 7831 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfzSj6d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:11:15 INFO - PROCESS | 7831 | RSS: Main: 141619200 02:11:15 INFO - PROCESS | 7831 | 02:14:17 INFO - PROCESS | 7831 | Cycle 1(1): loaded http://localhost:37783/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37783/tests/dromaeo/cssquery-ext.html) 02:14:18 INFO - PROCESS | 7831 | RSS: Main: 272326656 02:14:18 INFO - PROCESS | 7831 | 02:17:20 INFO - PROCESS | 7831 | Cycle 1(1): loaded http://localhost:37783/tests/dromaeo/cssquery-ext.html (next: http://localhost:37783/tests/dromaeo/cssquery-jquery.html) 02:17:21 INFO - PROCESS | 7831 | RSS: Main: 225951744 02:17:21 INFO - PROCESS | 7831 | 02:20:23 INFO - PROCESS | 7831 | Cycle 1(1): loaded http://localhost:37783/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37783/tests/dromaeo/cssquery-mootools.html) 02:20:23 INFO - PROCESS | 7831 | RSS: Main: 217800704 02:20:23 INFO - PROCESS | 7831 | 02:23:25 INFO - PROCESS | 7831 | Cycle 1(1): loaded http://localhost:37783/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37783/tests/dromaeo/cssquery-prototype.html) 02:23:26 INFO - PROCESS | 7831 | RSS: Main: 213594112 02:23:26 INFO - PROCESS | 7831 | 02:26:28 INFO - PROCESS | 7831 | Cycle 1(1): loaded http://localhost:37783/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37783/tests/dromaeo/cssquery-yui.html) 02:26:29 INFO - PROCESS | 7831 | RSS: Main: 174219264 02:26:29 INFO - PROCESS | 7831 | 02:29:31 INFO - PROCESS | 7831 | Cycle 1(1): loaded http://localhost:37783/tests/dromaeo/cssquery-yui.html (next: http://localhost:37783/tests/dromaeo/cssquery-dojo.html) 02:29:32 INFO - PROCESS | 7831 | RSS: Main: 260485120 02:29:32 INFO - PROCESS | 7831 | 02:29:32 INFO - PROCESS | 7831 | __start_tp_report 02:29:32 INFO - PROCESS | 7831 | _x_x_mozilla_page_load 02:29:32 INFO - PROCESS | 7831 | _x_x_mozilla_page_load_details 02:29:32 INFO - PROCESS | 7831 | |i|pagename|runs| 02:29:32 INFO - PROCESS | 7831 | |0;dojo.html;3420.2646431017333;3426.657334266572;3455.378031954248;3471.8437670304834;3488.59881113672;5663.490285874271;5748.942510574893;5763.798267060653;5768.711564421777;5769.278840144987;5716.085426331788;5753.165790960308;5762.222100016496;5763.682997435149;5768.625039372438;5069.695818250917;5069.923951140736;5108.310378098965;5115.9744201278945;5147.408048074463;4954.232094025432;4965.428975667808;5162.483751624826;5175.171972484403;5208.817691380802;5050.520200580939;5085.389753229618;5141.0489059523925;5150.098732721777;5166.121759300909;5173.405058418292;5176.404713457963;5183.792648294064;5186.740662966837;5205.193195054772;4862.854114376574;5011.699298042093;5080.339555857715;5115.667481613683;5132.204508301219;5545.195946587763;5564.4713752193475;5631.4087020863035;5671.149327600851;5678.403767604384;6084.908726369108;6127.11156882254;6133.509319254449;6135.6625385603775;6137.386261373871;6170.413810687977;6192.225971753531;6195.597286176384;6198.752049917998;6199.132121502993;5535.114381698949;5581.05122129239;5700.116481945263;5726.541876649858;5743.3395159557185;6309.526785491106;6310.337414571496;6315.55791094619;6315.715792789336;6315.96842015787;6040;6086.391360863879;6088.178095957078;6101.969490152521;6102.664353460514;5846.41535846412;5886.264216972879;6025.3974602540275;6049.848753781191;6180.134781130645;6093.908591371133;6098.451139397475;6107.389261073857;6114.327423983358;6123.877522449615;5855.648661080349;5903.911441328383;5907.409259074144;5912.17229587858;6120.6299886969155;4654.464736555339;4659.114768194032;4688.601468875184;4688.929666055012;4704.95295047052;4240.554741752133;4249.107687385622;4249.97875010623;4267.4025636410925;4297.763623000703;5646.858828529237;5670.631408958487;5816.651000939873;5817.7382017809305;5828.79599214034;6161.353057928853;6223;6238.376162383725;6239.06414037898;6243.094751261133;5914;5920;5927.170196172539;5928.288605367384;5954.732037058343;5055.494450554915;5098.745062746922;5203.453637368022;5245.842624721265;5266.78932842682;6512.479001679854;6536.509761767791;6540.6729663516635;6544.214694236817;6545.443637290884;6135.233095863017;6137.539684523589;6180.4746596538;6190.350013248544;6194.938050619436;6160.938390616216;6200.441960223601;6346.936530634819;6544.869102617826;6558.147440832661;6119.746288422794;6128.019516877278;6128.625347140905;6129.14485165794;6134.294556126102;6188.504919606331;6200.596961197508;6201.255849298113;6206.937930620636;6210.31686514474;5643.548516118783;5742.856428589319;6036.969815151072;6042.1540984261355;6045.776013846276;5905.498032667099;5940.316863560746;6028.819135425944;6033.607815491979;6043.8186854394435;5949.940500594938;5984.850378740566;5992.310884248367;5992.610480318765;5998.670073146019;5710.457506536873;5722.74247658848;5766.682832444256;5769.105788602773;6033.818985430444;5822.563307752021;5828.970855145697;5843.328017278068;5862.560307977004;5865.882682346244 02:29:32 INFO - PROCESS | 7831 | |1;ext.html;775.2557544757033;836.05943313772;857.3227150551065;911.9042500537439;919.5034681272114;30963.380732385365;44651.33023004657;45635.54364456354;45781.31328030078;45815.312770308476;41907.58092419075;42199.789001055025;42255.154896902044;46217.537824621744;46292.53707462925;7861.410394220427;8023.879641805378;9237.676681316156;9363.812723745521;9366.765830854216;10821;11047.116230701524;11048.779024419508;11058.723531911726;11377.829332560019;11033.227674062819;11037;11074.114070874311;11075;11081.168912331566;11023.338599683964;11044.171687123458;11061.336319820837;11074.667759967213;11075.667729968034;10814.297070690458;10847.891521084846;10878.72803179919;10880.347179169275;10884.346939183675;44020.11959760819;44063.55936440659;44190.33714494285;44216.55783442189;44331.33502997458;4193.496780386373;4265.808038638269;4331.826726930919;4449.4660640723;4499.370088187657;30223.848880755675;30887.691123088705;30897.536536951964;31114.377712445625;31633.84183079093;4279.550647182032;4324.545922678137;4337.132573485315;4340.978295108504;4393.890152746175;234715;235297;235840;237006.99999999828;237273;53474.73262633662;53582;53681.46318536765;53704;53808.19287710688;56275;56834.7158264206;56881.431185687616;56896.431035689115;56959.71520142373;16706.4152754653;17033.148342582823;17083.658326833392;17117.400890968755;17191.484255472355;11386.202965792481;11592.304461732323;14765;15013.699726005638;15019.624509387353;14202.289885505683;14324.355404006845;14391.640208994859;14418.639534011734;14437.133771973715;5725.370209276976;5729.627574207663;5786.88426231473;5795.275590551181;5847.26909136358;1016.9593216271414;1017.760826205841;1018.6078359831519;1019.6686077024997;1031.9226058045676;28390.290242744097;28394.148175554765;28545.71454285472;28701.85649071783;28862;1061.0874647802884;1070.8768491623564;1071.052118874786;1106.811841986848;1108.3239224073309;15062.849371506363;15265.847341526665;15284.923575382052;15380.846191537941;15399.846001539841;289605;290432;291191;291736;291989;56656;56829.431705683244;56922;57040.42959570434;57042;1473.1087691946218;1487.4050379847931;1496.0649594003748;1504.601280660626;1560.8683704314508;28205.57691634586;28477.288067797643;28965;29500.11499655014;29740.553891692074;36752.816235918646;36940;36942;36953.815230923676;36954;292871;293569;293721;293888;448477;25489.617655734808;25866.09468668663;25888.352791180372;29681.406371872872;30576.541351880183;40052.39921401123;40306.1938761229;40326.1934761309;40360.59639403568;40598.39102413407;31752.523712144797;31968.36063278768;32081.19797005;32261.677383226805;32599.837000814845;30829.845850770602;31241.68758312388;31353.372932540766;31459.37081258316;31467.685323146474;35243.95547269016;35441.46837797487;35726;35918.28163436769;36389.63610363862;30013.69986300109;30205;30288.69711302947;30420.23949401194;30705;23804.761952380253;24450.388740281636;24452.388690282885;24722.25833225006;25113.74886251114 02:29:32 INFO - PROCESS | 7831 | |2;jquery.html;469.8989717210799;473.5312041079328;478.57645983304764;479.1590758219327;493.2157868988309;20101.59796804065;22061;22975.77024229757;23082.538349233004;23333.300000999996;22222.222222222226;22531.54936901261;22947.885260573672;22955.08179672811;23144.42138946527;6716.865662686743;6776.085228494139;6922.48081393895;6962.930370696305;6971.79084627462;6914.274001229874;7028.086348774652;7285;7583.962080189592;7601.429892758038;7167.569945803242;7755.224477552228;7762.184970578092;7764.883526747103;7770.222977702241;7488.850222995537;7573.318401343878;7594.354479869217;7595.240475952416;7595.924040759577;7182.06633137694;7340.632968351614;7394.408447324255;7400.185979542246;7400.70397184112;23938.40153996164;24283.27150185497;24841.751582484307;25527.361815954562;26445.3388665283;3104.7671424643017;3166.904992850218;3209.903702888917;3225.3710526447353;3276.2300859298048;15918.920405398014;16040;16050;16215.189240537926;16334.264958076916;2189.189999700105;2280.9543809123725;2289.427643089228;2326.4183954011496;2337.4506990857135;107512;108858.45570772175;108959.45520272428;109541;109921.45039274833;17647.205875735624;17899.552511187063;18298.25526171085;18387.72418413725;18638.627227455374;31066.378672426876;31091.689083109333;31140.22149446282;31394.529082063786;31457.370852583277;10637.361758294526;10759.462026898624;10806.837897431546;10875;10914.945425272823;9189.264858811279;9218.124278193694;9235.353525253302;9261;9410.106039926197;9131.269498440242;9428;9474.763130921645;9488.762780930532;9504.809903801885;3641.6358364163902;3760.5863355030924;3948.565657777642;3954.915166170392;3956.8615098471414;954.231843366097;967.0716112531908;971.6356366362614;992.161623428202;994.5673631969971;19655;20926.895365523076;21330.360089197347;21407.46481337948;21527.33014535781;965.5992763003416;975.8292298847673;979.3585201692903;985.9950700246596;986.7286496213599;11246.931541503707;11790.469428875549;11899.762004759856;11956;12100.33448160342;590066;619889;623405;626414;632196;70923.2907670927;72191.63904180446;75245.24754752492;81765;104186.47906760417;1225.4694056772735;1255.805350170725;1268.4165283969478;1268.7843066678686;1270.6442196185083;18246.817531824512;18434.63130737351;18740.90629546898;18912.905435472734;18934.43196704101;44634.77682611566;44861;45180.322295164944;45285;45297.54702452933;63770.36229637644;63893;64315;64694;65825.34174658384;12179.08656850722;12339.13626046168;12339.568115115928;12385.380730963596;12440.564580239648;13940.930295348458;13998.090124141898;14061.086029408056;14265.286735663383;14339.139651620937;6400.967995159995;11151;11479.36863472517;12059.336736479578;12386.81419778686;10499.212559057949;10811.729706757395;11360.715982100513;11659.766804664028;11855.229410088317;6137.232845894263;11563.364014979257;12192.87807121953;12194.390280486117;12331.876681233072;12500.00000000016;12523.874761252271;12533.310667913353;12644.114911956074;12778.169418987736;11476.483558240066;11846.407679615812;11945.283283003047;12027.398630068637;12324 02:29:32 INFO - PROCESS | 7831 | |3;mootools.html;1459.6642772162395;1573.3470609696974;1587.6110352963526;1630.8124565674943;1636.909969951653;9657.855132173014;11083.168762342826;11444.084473242141;11454.083673306137;11474.254173478728;11489.885101149006;11530.942345288282;11559;11562.826557601622;11575.768484630324;2028.98985505073;2092.926747563828;2370.9644355334685;2407.4703565215623;2408.3136306152664;2466.839655422392;2528.266802627236;2534.9239522814346;2539.225536211464;2540.923772286825;2455.4475243070256;2473.985665876991;2479.7396273391305;2481.565725997943;2483.379155211197;2434.245383930987;2448.485817978209;2466.0628960994795;2472.8392654477493;2473.51766405551;2329.7553756855623;2383.3088404362716;2384.952300953971;2387.164492427654;2389.6057150570136;11493.770124597544;11766.11754118436;11779;11782.175247732663;11789.646310610695;5845.064789633639;5971.880562388771;5972.492338151263;5979.342272350038;5979.880402391971;3483.860645574174;3485.268093700326;3559.928801423983;3596.1369271374683;3652.7808331500196;1348.9055766096378;1379.3585982518077;1396.2809153286066;1417.5322143692556;1436.3177490691942;16756.832431675648;16891.915540422342;16901;17105.657886842317;17142.05718685472;4872.78072486739;4897.1185186666025;4991.900161996739;4992.675476094042;5078.035173317058;14222.644433889029;14229.64425889361;14231.07498012626;14253.857461425461;14262.215578143094;6074.088886667036;6078.75684972605;6092.72582733778;6093.390660933871;6098.695065246809;5347.465253474621;5533.612647114744;5564.109742441271;5599.832005039855;5609.0184217761725;4363.716358436692;4452.9554704453185;4464.441944756905;4508.571685689854;4513.435820522434;1179.33367647279;1194.6798787340038;1208.4984731336397;1213.1023042948332;1218.3786269002871;892.3262936482914;931.8695382646434;948.6205517792938;951.039450155348;955.1880901234034;6901.516893817485;6912.827179320558;6954.478414118961;7036.226015138331;7081.92918070823;1049.338916482611;1054.8734151901822;1071.5338827610015;1085.2620218251664;1085.9891401086047;4606.746628935373;4635.165670179333;4637.211674015425;4720.244760838249;4813.205821039559;13714.588562343146;14429.494967676292;14474.131552106906;14485.203313817841;14494.855051449562;13897.930510347383;14322.14067155974;14416.855831441551;14978.325975331136;14980.550583482513;10644.787104258026;10839.349639021684;10840.078593319498;10848.78302433947;10876.836847447295;7399.704011839466;7620.695172193272;7632.656530456254;7652.005239318853;7843.8039049021945;12775.55285565038;13019.33258223076;13055.869441305846;13078.084534082524;13315.66710832237;10476.895231047592;13109.410076546388;13179.538716145273;13275.336233188109;13293.20240785556;9911.900880991097;10026.849597256192;10107.949460252652;10132.240081993732;10251.487425628839;10938.835917461403;10956.890431095906;11029.669109926715;11042.171837112088;11048.558057677603;9440.527973601154;9493.05069493045;9545.236381089357;9583.568739406604;9649.855252171363;9177.77055573616;9238.491882946233;9269.907300926905;9330.813383732424;9457.668981585612;7971.641276142704;8072.798180045545;8202.056763472277;8210.63052162642;8212;6705.798826035227;6778.966105169443;6794.252632210354;6819.079424277659;6860.451163906975;6716.227633821977;6719.630420326929;6892.172939247323;6957.478189135733;6997.475189360716 02:29:32 INFO - PROCESS | 7831 | |4;prototype.html;429.2980976104069;429.48032880214936;444.72427095200976;455.6195576693461;457.2775015475548;5184.53339199472;5222.9477705222935;5242.737863106844;5252.238425428311;5254.842354729355;5032.874178145548;5130.666506677073;5139.820106296281;5159.3808742950805;5161.741912904358;4335.783210839461;4336.701548179454;4348.999460248289;4351.325544540601;4381.671374646899;4347.847825326115;4354.564543545652;4368.126374725051;4371.229651990949;4378.6715996300245;4213.7893105344765;4265.87202383929;4338.978305108486;4355.825766969318;4358.6077253047215;4272.530021697611;4296.978515107405;4346.783140598286;4347.500037495681;4350;4051.97974010131;4064.735792173529;4104.281750693616;4108.281050816096;4151.83392664293;5029.84910452687;5064.82273120439;5103.744812759384;5130.4356520782685;5134.64057515974;5044.722540260284;5051.116054690451;5075.426617748473;5079.517445842639;5086.567641750418;5358.892822143574;5423.7830486780485;5429.53848922842;5432.619716619838;5442.156465747816;4466.285394336923;4487.816571859475;4543.727376357429;4543.863684089482;4569.543045695437;5429.886873190986;5544.696996205888;5584.720763961826;5630.887382252332;5650.802221922213;4686.882827929261;4688.2030054890065;4692.694974826625;4722.220833562493;4736.171170045228;4592.586667199968;4600.2869555218995;4628.467726211529;4809.134355815987;4845.442774080955;4987.80048798044;5039.143345631252;5052.823151189691;5070.670406423571;5095.490450954949;5447.291852059287;5447.863803404946;5461.617686761889;5477.260569823023;5511.255980442669;1575.8030246219223;1631.0947424179458;1639.6146905477203;1645.3007471824667;1648.3406637345158;1247.1394737631006;1269.800038963171;1272.9370975235781;1283.6277479530831;1301.1347453943022;5349.004557447842;5395.785948161711;5400.540954018952;5428.945710542923;5441.238226648194;5584.5811564132855;5625.8593535161945;5635.5347609621795;5638.238837756932;5647.6329038613185;5206.672298563918;5312.362516497968;5340.279062326614;5368.32895888014;5394.487523685244;2896.2759310172455;2937.3831495386207;2944.0275015739508;2949.4985852405143;2958.704129587024;5657.264555607745;5876.970615146897;5915.792947246826;5921;5947.542852001201;5698.17376480408;5708.257926469532;5723.484886360247;5723.627964182315;5764.481196692318;5837.357890632027;5869.325027621878;5936.426846885579;5958.880822383615;5969.52243820502;5307.734613269244;5623.943760562342;5642.435756424489;5692.800751973661;5718.3423906249645;5286.312779338815;5373.758180881948;5411.728243862611;5524.779008839762;5564.4991950724625;5836.795712150224;5895.498882594856;5899.410058994066;5900.409959004065;5944.1975333331175;4545.886352841073;4642.651801114997;4756.6908150970075;4758.119747846659;4759.7858096386435;5546.3638226722405;5568.972155139199;5584.525315348241;5607.383187849252;5638.37977822431;5466.644668096561;5474.753636086465;5479.260369815092;5527.364353099445;5529.889402211853;5346.348676651338;5454.4545545445135;5491.478309560585;5505.091659876076;5527.419620939743;5419.374187743582;5479.315085614298;5485;5508.394076651645;5534.367361628249;5497.47773961473;5517.834464965897;5524.33707955048;5539.947409992089;5555.583331250092;5178.171492561323;5351.812686555952;5372.355317361941;5391.353037635509;5394.277948215718 02:29:32 INFO - PROCESS | 7831 | |5;yui.html;843.2916350265775;904.3850181876323;904.7602385367877;934.3272843552649;936.7002559181061;16417.83582164178;16428.342866285348;17152.48542543724;17500.299988000497;17667.381641642543;16760.078195699232;17222;17722.911385443087;17850.28598856044;17866.285348586072;900.774806298427;920.4155361345561;923.1829830599934;923.6536298887917;924.0620769918538;872.2585802068255;901.292485398962;909.2044461096541;910.3854897943894;910.4855756497558;956.4739393333673;959.1080295325345;959.122403001253;959.2853324273426;960.2366118935463;955.1356022799343;957.2150836314225;957.4398976598698;957.7414098193484;957.8323793336139;705.1855107350966;705.9011738356634;707.5436343558428;707.6002058836741;707.780588017711;16431.753523697036;16590.83409165905;16907;17473.912630436767;17478.300867965267;15845.68308633821;16112;16236.83763162365;16424.09667468289;16604.916975415046;13141.948644108448;13330.73338533224;13357.13178643385;13525.120867143603;13549.254790986492;3953.5453422856162;4001.2597669430957;4031.314676505001;4063.817128229237;4111.321631930728;83776;84134.57932710358;85784;86695;87221.56389218077;11909.589546104573;11921.34432606215;12020.579279725343;12048.457819397972;12250.693732656577;23710.17014404522;24011.7598824013;24023;24121.879390603284;24234;8318.8336233275;8339.291160251447;8545.060043395222;8561.828763424697;8563;4729.716217026989;4806.431182457847;4833.081714474239;4891.997140586172;4925.359703238628;3658.432942893856;3734.10381508436;3740.7381483296454;3775.679067279312;3859.9421008684894;633.5090305013651;642.82322361351;644.7453255963868;656.9605823650596;666.9299723528959;681.5535824035264;683.1392445518683;704.8907419350008;709.5529816215854;712.3410844968383;11499.367534785668;11755.764884702428;12313.26120432777;12428.316442595744;12741.235525868478;825.793551612097;848.1772680499905;853.833502467013;871.9564021799011;874.4490970688553;5439.238506609078;5631.2397826293745;5678.432156784289;5777.422257774189;5778.508826749773;82077.76883346755;82961.58519207485;85140.57429712935;85752.14247857567;87122;42187.36718949218;44648.553514465086;50258;58555.41444585585;73873.26126738664;55213;59997.400026000054;60655;61033;62159.68920155461;11394.601188958346;11684.889935456118;11712.531498739954;11890.524379025088;12055.758884822078;42270.78864605657;42487.93780155521;42727;43778.78110609426;43928.56071439245;47078.293825593326;47526.52473475221;48108.27837582369;49532.75233623809;49905.750471248866;12883.776041276064;13069.607911762663;13102.672433189247;13243.337833108499;13295.135816171918;16013.599660008593;16394.344226230816;16455.67088658196;16522.17389130563;16584.83415165881;15492.922535387252;15695.764563531327;15725.135117568643;15773.605659858595;16258.349666013228;15993.8400615997;16430.955029397668;17261.136943153044;17641.117944103;18113.45659630213;16576.336946522486;16682.249298781826;17727.911360443115;17874.5531361717;18055.638887222445;11054.22620416563;11080.889191107986;11532.654020379403;12103.75792484163;12496.06279529057;13393.727595878376;13537.864621353661;13793.448262069805;13854.861451385761;14079.436822526985 02:29:32 INFO - PROCESS | 7831 | __end_tp_report 02:29:32 INFO - PROCESS | 7831 | __start_cc_report 02:29:32 INFO - PROCESS | 7831 | _x_x_mozilla_cycle_collect,1300 02:29:32 INFO - PROCESS | 7831 | __end_cc_report 02:29:32 INFO - PROCESS | 7831 | __startTimestamp1496914172128__endTimestamp 02:29:32 INFO - PROCESS | 7831 | 02:29:32 INFO - PROCESS | 7831 | ------- Summary: start ------- 02:29:32 INFO - PROCESS | 7831 | Number of tests: 6 02:29:32 INFO - PROCESS | 7831 | 02:29:32 INFO - PROCESS | 7831 | [#0] dojo.html Cycles:165 Average:5680.54 Median:5865.88 stddev:652.60 (11.1%) stddev-sans-first:630.05 02:29:32 INFO - PROCESS | 7831 | Values: 3420.3 3426.7 3455.4 3471.8 3488.6 5663.5 5748.9 5763.8 5768.7 5769.3 5716.1 5753.2 5762.2 5763.7 5768.6 5069.7 5069.9 5108.3 5116.0 5147.4 4954.2 4965.4 5162.5 5175.2 5208.8 5050.5 5085.4 5141.0 5150.1 5166.1 5173.4 5176.4 5183.8 5186.7 5205.2 4862.9 5011.7 5080.3 5115.7 5132.2 5545.2 5564.5 5631.4 5671.1 5678.4 6084.9 6127.1 6133.5 6135.7 6137.4 6170.4 6192.2 6195.6 6198.8 6199.1 5535.1 5581.1 5700.1 5726.5 5743.3 6309.5 6310.3 6315.6 6315.7 6316.0 6040.0 6086.4 6088.2 6102.0 6102.7 5846.4 5886.3 6025.4 6049.8 6180.1 6093.9 6098.5 6107.4 6114.3 6123.9 5855.6 5903.9 5907.4 5912.2 6120.6 4654.5 4659.1 4688.6 4688.9 4705.0 4240.6 4249.1 4250.0 4267.4 4297.8 5646.9 5670.6 5816.7 5817.7 5828.8 6161.4 6223.0 6238.4 6239.1 6243.1 5914.0 5920.0 5927.2 5928.3 5954.7 5055.5 5098.7 5203.5 5245.8 5266.8 6512.5 6536.5 6540.7 6544.2 6545.4 6135.2 6137.5 6180.5 6190.4 6194.9 6160.9 6200.4 6346.9 6544.9 6558.1 6119.7 6128.0 6128.6 6129.1 6134.3 6188.5 6200.6 6201.3 6206.9 6210.3 5643.5 5742.9 6037.0 6042.2 6045.8 5905.5 5940.3 6028.8 6033.6 6043.8 5949.9 5984.9 5992.3 5992.6 5998.7 5710.5 5722.7 5766.7 5769.1 6033.8 5822.6 5829.0 5843.3 5862.6 5865.9 02:29:32 INFO - PROCESS | 7831 | 02:29:32 INFO - PROCESS | 7831 | [#1] ext.html Cycles:180 Average:45237.19 Median:30256.27 stddev:75421.54 (249.3%) stddev-sans-first:75559.24 02:29:32 INFO - PROCESS | 7831 | Values: 775.3 836.1 857.3 911.9 919.5 30963.4 44651.3 45635.5 45781.3 45815.3 41907.6 42199.8 42255.2 46217.5 46292.5 7861.4 8023.9 9237.7 9363.8 9366.8 10821.0 11047.1 11048.8 11058.7 11377.8 11033.2 11037.0 11074.1 11075.0 11081.2 11023.3 11044.2 11061.3 11074.7 11075.7 10814.3 10847.9 10878.7 10880.3 10884.3 44020.1 44063.6 44190.3 44216.6 44331.3 4193.5 4265.8 4331.8 4449.5 4499.4 30223.8 30887.7 30897.5 31114.4 31633.8 4279.6 4324.5 4337.1 4341.0 4393.9 234715.0 235297.0 235840.0 237007.0 237273.0 53474.7 53582.0 53681.5 53704.0 53808.2 56275.0 56834.7 56881.4 56896.4 56959.7 16706.4 17033.1 17083.7 17117.4 17191.5 11386.2 11592.3 14765.0 15013.7 15019.6 14202.3 14324.4 14391.6 14418.6 14437.1 5725.4 5729.6 5786.9 5795.3 5847.3 1017.0 1017.8 1018.6 1019.7 1031.9 28390.3 28394.1 28545.7 28701.9 28862.0 1061.1 1070.9 1071.1 1106.8 1108.3 15062.8 15265.8 15284.9 15380.8 15399.8 289605.0 290432.0 291191.0 291736.0 291989.0 56656.0 56829.4 56922.0 57040.4 57042.0 1473.1 1487.4 1496.1 1504.6 1560.9 28205.6 28477.3 28965.0 29500.1 29740.6 36752.8 36940.0 36942.0 36953.8 36954.0 292871.0 293569.0 293721.0 293888.0 448477.0 25489.6 25866.1 25888.4 29681.4 30576.5 40052.4 40306.2 40326.2 40360.6 40598.4 31752.5 31968.4 32081.2 32261.7 32599.8 30829.8 31241.7 31353.4 31459.4 31467.7 35244.0 35441.5 35726.0 35918.3 36389.6 30013.7 30205.0 30288.7 30420.2 30705.0 23804.8 24450.4 24452.4 24722.3 25113.7 02:29:32 INFO - PROCESS | 7831 | 02:29:32 INFO - PROCESS | 7831 | [#2] jquery.html Cycles:180 Average:35216.07 Median:24562.51 stddev:101454.17 (413.0%) stddev-sans-first:101705.23 02:29:32 INFO - PROCESS | 7831 | Values: 469.9 473.5 478.6 479.2 493.2 20101.6 22061.0 22975.8 23082.5 23333.3 22222.2 22531.5 22947.9 22955.1 23144.4 6716.9 6776.1 6922.5 6962.9 6971.8 6914.3 7028.1 7285.0 7584.0 7601.4 7167.6 7755.2 7762.2 7764.9 7770.2 7488.9 7573.3 7594.4 7595.2 7595.9 7182.1 7340.6 7394.4 7400.2 7400.7 23938.4 24283.3 24841.8 25527.4 26445.3 3104.8 3166.9 3209.9 3225.4 3276.2 15918.9 16040.0 16050.0 16215.2 16334.3 2189.2 2281.0 2289.4 2326.4 2337.5 107512.0 108858.5 108959.5 109541.0 109921.5 17647.2 17899.6 18298.3 18387.7 18638.6 31066.4 31091.7 31140.2 31394.5 31457.4 10637.4 10759.5 10806.8 10875.0 10914.9 9189.3 9218.1 9235.4 9261.0 9410.1 9131.3 9428.0 9474.8 9488.8 9504.8 3641.6 3760.6 3948.6 3954.9 3956.9 954.2 967.1 971.6 992.2 994.6 19655.0 20926.9 21330.4 21407.5 21527.3 965.6 975.8 979.4 986.0 986.7 11246.9 11790.5 11899.8 11956.0 12100.3 590066.0 619889.0 623405.0 626414.0 632196.0 70923.3 72191.6 75245.2 81765.0 104186.5 1225.5 1255.8 1268.4 1268.8 1270.6 18246.8 18434.6 18740.9 18912.9 18934.4 44634.8 44861.0 45180.3 45285.0 45297.5 63770.4 63893.0 64315.0 64694.0 65825.3 12179.1 12339.1 12339.6 12385.4 12440.6 13940.9 13998.1 14061.1 14265.3 14339.1 6401.0 11151.0 11479.4 12059.3 12386.8 10499.2 10811.7 11360.7 11659.8 11855.2 6137.2 11563.4 12192.9 12194.4 12331.9 12500.0 12523.9 12533.3 12644.1 12778.2 11476.5 11846.4 11945.3 12027.4 12324.0 02:29:32 INFO - PROCESS | 7831 | 02:29:32 INFO - PROCESS | 7831 | [#3] mootools.html Cycles:180 Average:7240.99 Median:2460.76 stddev:4566.22 (185.6%) stddev-sans-first:4558.36 02:29:32 INFO - PROCESS | 7831 | Values: 1459.7 1573.3 1587.6 1630.8 1636.9 9657.9 11083.2 11444.1 11454.1 11474.3 11489.9 11530.9 11559.0 11562.8 11575.8 2029.0 2092.9 2371.0 2407.5 2408.3 2466.8 2528.3 2534.9 2539.2 2540.9 2455.4 2474.0 2479.7 2481.6 2483.4 2434.2 2448.5 2466.1 2472.8 2473.5 2329.8 2383.3 2385.0 2387.2 2389.6 11493.8 11766.1 11779.0 11782.2 11789.6 5845.1 5971.9 5972.5 5979.3 5979.9 3483.9 3485.3 3559.9 3596.1 3652.8 1348.9 1379.4 1396.3 1417.5 1436.3 16756.8 16891.9 16901.0 17105.7 17142.1 4872.8 4897.1 4991.9 4992.7 5078.0 14222.6 14229.6 14231.1 14253.9 14262.2 6074.1 6078.8 6092.7 6093.4 6098.7 5347.5 5533.6 5564.1 5599.8 5609.0 4363.7 4453.0 4464.4 4508.6 4513.4 1179.3 1194.7 1208.5 1213.1 1218.4 892.3 931.9 948.6 951.0 955.2 6901.5 6912.8 6954.5 7036.2 7081.9 1049.3 1054.9 1071.5 1085.3 1086.0 4606.7 4635.2 4637.2 4720.2 4813.2 13714.6 14429.5 14474.1 14485.2 14494.9 13897.9 14322.1 14416.9 14978.3 14980.6 10644.8 10839.3 10840.1 10848.8 10876.8 7399.7 7620.7 7632.7 7652.0 7843.8 12775.6 13019.3 13055.9 13078.1 13315.7 10476.9 13109.4 13179.5 13275.3 13293.2 9911.9 10026.8 10107.9 10132.2 10251.5 10938.8 10956.9 11029.7 11042.2 11048.6 9440.5 9493.1 9545.2 9583.6 9649.9 9177.8 9238.5 9269.9 9330.8 9457.7 7971.6 8072.8 8202.1 8210.6 8212.0 6705.8 6779.0 6794.3 6819.1 6860.5 6716.2 6719.6 6892.2 6957.5 6997.5 02:29:32 INFO - PROCESS | 7831 | 02:29:32 INFO - PROCESS | 7831 | [#4] prototype.html Cycles:180 Average:4778.87 Median:5253.54 stddev:1273.36 (24.2%) stddev-sans-first:1234.38 02:29:32 INFO - PROCESS | 7831 | Values: 429.3 429.5 444.7 455.6 457.3 5184.5 5222.9 5242.7 5252.2 5254.8 5032.9 5130.7 5139.8 5159.4 5161.7 4335.8 4336.7 4349.0 4351.3 4381.7 4347.8 4354.6 4368.1 4371.2 4378.7 4213.8 4265.9 4339.0 4355.8 4358.6 4272.5 4297.0 4346.8 4347.5 4350.0 4052.0 4064.7 4104.3 4108.3 4151.8 5029.8 5064.8 5103.7 5130.4 5134.6 5044.7 5051.1 5075.4 5079.5 5086.6 5358.9 5423.8 5429.5 5432.6 5442.2 4466.3 4487.8 4543.7 4543.9 4569.5 5429.9 5544.7 5584.7 5630.9 5650.8 4686.9 4688.2 4692.7 4722.2 4736.2 4592.6 4600.3 4628.5 4809.1 4845.4 4987.8 5039.1 5052.8 5070.7 5095.5 5447.3 5447.9 5461.6 5477.3 5511.3 1575.8 1631.1 1639.6 1645.3 1648.3 1247.1 1269.8 1272.9 1283.6 1301.1 5349.0 5395.8 5400.5 5428.9 5441.2 5584.6 5625.9 5635.5 5638.2 5647.6 5206.7 5312.4 5340.3 5368.3 5394.5 2896.3 2937.4 2944.0 2949.5 2958.7 5657.3 5877.0 5915.8 5921.0 5947.5 5698.2 5708.3 5723.5 5723.6 5764.5 5837.4 5869.3 5936.4 5958.9 5969.5 5307.7 5623.9 5642.4 5692.8 5718.3 5286.3 5373.8 5411.7 5524.8 5564.5 5836.8 5895.5 5899.4 5900.4 5944.2 4545.9 4642.7 4756.7 4758.1 4759.8 5546.4 5569.0 5584.5 5607.4 5638.4 5466.6 5474.8 5479.3 5527.4 5529.9 5346.3 5454.5 5491.5 5505.1 5527.4 5419.4 5479.3 5485.0 5508.4 5534.4 5497.5 5517.8 5524.3 5539.9 5555.6 5178.2 5351.8 5372.4 5391.4 5394.3 02:29:32 INFO - PROCESS | 7831 | 02:29:32 INFO - PROCESS | 7831 | [#5] yui.html Cycles:180 Average:18217.80 Median:42229.08 stddev:22083.85 (52.3%) stddev-sans-first:22107.26 02:29:32 INFO - PROCESS | 7831 | Values: 843.3 904.4 904.8 934.3 936.7 16417.8 16428.3 17152.5 17500.3 17667.4 16760.1 17222.0 17722.9 17850.3 17866.3 900.8 920.4 923.2 923.7 924.1 872.3 901.3 909.2 910.4 910.5 956.5 959.1 959.1 959.3 960.2 955.1 957.2 957.4 957.7 957.8 705.2 705.9 707.5 707.6 707.8 16431.8 16590.8 16907.0 17473.9 17478.3 15845.7 16112.0 16236.8 16424.1 16604.9 13141.9 13330.7 13357.1 13525.1 13549.3 3953.5 4001.3 4031.3 4063.8 4111.3 83776.0 84134.6 85784.0 86695.0 87221.6 11909.6 11921.3 12020.6 12048.5 12250.7 23710.2 24011.8 24023.0 24121.9 24234.0 8318.8 8339.3 8545.1 8561.8 8563.0 4729.7 4806.4 4833.1 4892.0 4925.4 3658.4 3734.1 3740.7 3775.7 3859.9 633.5 642.8 644.7 657.0 666.9 681.6 683.1 704.9 709.6 712.3 11499.4 11755.8 12313.3 12428.3 12741.2 825.8 848.2 853.8 872.0 874.4 5439.2 5631.2 5678.4 5777.4 5778.5 82077.8 82961.6 85140.6 85752.1 87122.0 42187.4 44648.6 50258.0 58555.4 73873.3 55213.0 59997.4 60655.0 61033.0 62159.7 11394.6 11684.9 11712.5 11890.5 12055.8 42270.8 42487.9 42727.0 43778.8 43928.6 47078.3 47526.5 48108.3 49532.8 49905.8 12883.8 13069.6 13102.7 13243.3 13295.1 16013.6 16394.3 16455.7 16522.2 16584.8 15492.9 15695.8 15725.1 15773.6 16258.3 15993.8 16431.0 17261.1 17641.1 18113.5 16576.3 16682.2 17727.9 17874.6 18055.6 11054.2 11080.9 11532.7 12103.8 12496.1 13393.7 13537.9 13793.4 13854.9 14079.4 02:29:32 INFO - PROCESS | 7831 | -------- Summary: end -------- 02:29:32 INFO - PROCESS | 7831 | 02:29:32 INFO - TEST-INFO | 7831: exit 0 02:29:32 INFO - TEST-OK | dromaeo_css | took 1115180ms 02:29:32 INFO - TEST-START | kraken 02:29:32 INFO - operating with platform_type : linux_ 02:29:32 INFO - Initialising browser for kraken test... 02:29:32 INFO - TEST-INFO | started process 8138 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpETzwWE/profile http://localhost:37783/getInfo.html) 02:29:36 INFO - PROCESS | 8138 | __metrics Screen width/height:1600/1200 02:29:36 INFO - PROCESS | 8138 | colorDepth:24 02:29:36 INFO - PROCESS | 8138 | Browser inner width/height: 1024/697 02:29:36 INFO - PROCESS | 8138 | __metrics 02:29:37 INFO - PROCESS | 8138 | 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:29:37 INFO - PROCESS | 8138 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:29:38 INFO - TEST-INFO | 8138: exit 0 02:29:38 INFO - Browser initialized. 02:29:38 INFO - Running cycle 1/1 for kraken test... 02:29:38 INFO - TEST-INFO | started process 8230 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpETzwWE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:29:50 INFO - PROCESS | 8230 | RSS: Main: 141742080 02:29:50 INFO - PROCESS | 8230 | 02:29:52 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:37783/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37783/tests/kraken/driver.html?testName=audio-beat-detection) 02:29:53 INFO - PROCESS | 8230 | RSS: Main: 184008704 02:29:53 INFO - PROCESS | 8230 | 02:29:56 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:37783/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37783/tests/kraken/driver.html?testName=audio-dft) 02:29:56 INFO - PROCESS | 8230 | RSS: Main: 174247936 02:29:56 INFO - PROCESS | 8230 | 02:29:59 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:37783/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37783/tests/kraken/driver.html?testName=audio-fft) 02:30:00 INFO - PROCESS | 8230 | RSS: Main: 265031680 02:30:00 INFO - PROCESS | 8230 | 02:30:02 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:37783/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37783/tests/kraken/driver.html?testName=audio-oscillator) 02:30:02 INFO - PROCESS | 8230 | RSS: Main: 171716608 02:30:02 INFO - PROCESS | 8230 | 02:30:04 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:37783/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37783/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:30:05 INFO - PROCESS | 8230 | RSS: Main: 174297088 02:30:05 INFO - PROCESS | 8230 | 02:30:08 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:37783/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37783/tests/kraken/driver.html?testName=imaging-darkroom) 02:30:08 INFO - PROCESS | 8230 | RSS: Main: 209367040 02:30:08 INFO - PROCESS | 8230 | 02:30:12 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:37783/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37783/tests/kraken/driver.html?testName=imaging-desaturate) 02:30:12 INFO - PROCESS | 8230 | RSS: Main: 211419136 02:30:12 INFO - PROCESS | 8230 | 02:30:15 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:37783/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37783/tests/kraken/driver.html?testName=json-parse-financial) 02:30:16 INFO - PROCESS | 8230 | RSS: Main: 211873792 02:30:16 INFO - PROCESS | 8230 | 02:30:17 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:37783/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37783/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:30:18 INFO - PROCESS | 8230 | RSS: Main: 174325760 02:30:18 INFO - PROCESS | 8230 | 02:30:19 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:37783/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37783/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:30:20 INFO - PROCESS | 8230 | RSS: Main: 180785152 02:30:20 INFO - PROCESS | 8230 | 02:30:22 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:37783/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37783/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:30:23 INFO - PROCESS | 8230 | RSS: Main: 190963712 02:30:23 INFO - PROCESS | 8230 | 02:30:25 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:37783/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37783/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:30:26 INFO - PROCESS | 8230 | RSS: Main: 199909376 02:30:26 INFO - PROCESS | 8230 | 02:30:28 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:37783/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37783/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:30:29 INFO - PROCESS | 8230 | RSS: Main: 195633152 02:30:29 INFO - PROCESS | 8230 | 02:30:31 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:37783/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37783/tests/kraken/driver.html?testName=ai-astar) 02:30:31 INFO - PROCESS | 8230 | RSS: Main: 246562816 02:30:31 INFO - PROCESS | 8230 | 02:30:31 INFO - PROCESS | 8230 | __start_tp_report 02:30:31 INFO - PROCESS | 8230 | _x_x_mozilla_page_load 02:30:31 INFO - PROCESS | 8230 | _x_x_mozilla_page_load_details 02:30:31 INFO - PROCESS | 8230 | |i|pagename|runs| 02:30:31 INFO - PROCESS | 8230 | |0;ai-astar;101;110;110;110;112;111;112;110;110;110 02:30:31 INFO - PROCESS | 8230 | |1;audio-beat-detection;139;116;115;152;116;116;115;115;135;116 02:30:31 INFO - PROCESS | 8230 | |2;audio-dft;160;161;161;159;160;158;160;159;160;159 02:30:31 INFO - PROCESS | 8230 | |3;audio-fft;75;75;75;104;75;75;75;76;102;77 02:30:31 INFO - PROCESS | 8230 | |4;audio-oscillator;83;82;102;82;82;82;97;82;82;100 02:30:31 INFO - PROCESS | 8230 | |5;imaging-gaussian-blur;112;113;113;112;112;112;113;113;113;112 02:30:31 INFO - PROCESS | 8230 | |6;imaging-darkroom;145;146;146;146;146;146;146;146;147;146 02:30:31 INFO - PROCESS | 8230 | |7;imaging-desaturate;94;94;94;94;95;93;93;94;93;93 02:30:31 INFO - PROCESS | 8230 | |8;json-parse-financial;55;54;55;53;54;57;56;55;53;56 02:30:31 INFO - PROCESS | 8230 | |9;json-stringify-tinderbox;52;52;52;53;53;52;53;52;53;53 02:30:31 INFO - PROCESS | 8230 | |10;stanford-crypto-aes;79;79;76;80;80;77;76;82;85;75 02:30:31 INFO - PROCESS | 8230 | |11;stanford-crypto-ccm;124;123;121;127;121;122;121;126;156;141 02:30:31 INFO - PROCESS | 8230 | |12;stanford-crypto-pbkdf2;157;155;164;160;164;162;157;157;160;160 02:30:31 INFO - PROCESS | 8230 | |13;stanford-crypto-sha256-iterative;59;59;63;61;59;60;59;58;68;59 02:30:31 INFO - PROCESS | 8230 | __end_tp_report 02:30:31 INFO - PROCESS | 8230 | __start_cc_report 02:30:31 INFO - PROCESS | 8230 | _x_x_mozilla_cycle_collect,1665 02:30:31 INFO - PROCESS | 8230 | __end_cc_report 02:30:31 INFO - PROCESS | 8230 | __startTimestamp1496914231450__endTimestamp 02:30:31 INFO - PROCESS | 8230 | 02:30:31 INFO - PROCESS | 8230 | ------- Summary: start ------- 02:30:31 INFO - PROCESS | 8230 | Number of tests: 14 02:30:31 INFO - PROCESS | 8230 | 02:30:31 INFO - PROCESS | 8230 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:3.13 (2.8%) stddev-sans-first:0.88 02:30:31 INFO - PROCESS | 8230 | Values: 101.0 110.0 110.0 110.0 112.0 111.0 112.0 110.0 110.0 110.0 02:30:31 INFO - PROCESS | 8230 | 02:30:31 INFO - PROCESS | 8230 | [#1] audio-beat-detection Cycles:10 Average:123.50 Median:116.00 stddev:13.44 (11.6%) stddev-sans-first:13.04 02:30:31 INFO - PROCESS | 8230 | Values: 139.0 116.0 115.0 152.0 116.0 116.0 115.0 115.0 135.0 116.0 02:30:31 INFO - PROCESS | 8230 | 02:30:31 INFO - PROCESS | 8230 | [#2] audio-dft Cycles:10 Average:159.70 Median:160.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 02:30:31 INFO - PROCESS | 8230 | Values: 160.0 161.0 161.0 159.0 160.0 158.0 160.0 159.0 160.0 159.0 02:30:31 INFO - PROCESS | 8230 | 02:30:31 INFO - PROCESS | 8230 | [#3] audio-fft Cycles:10 Average:80.90 Median:75.00 stddev:11.68 (15.6%) stddev-sans-first:12.19 02:30:31 INFO - PROCESS | 8230 | Values: 75.0 75.0 75.0 104.0 75.0 75.0 75.0 76.0 102.0 77.0 02:30:31 INFO - PROCESS | 8230 | 02:30:31 INFO - PROCESS | 8230 | [#4] audio-oscillator Cycles:10 Average:87.40 Median:82.00 stddev:8.55 (10.4%) stddev-sans-first:8.92 02:30:31 INFO - PROCESS | 8230 | Values: 83.0 82.0 102.0 82.0 82.0 82.0 97.0 82.0 82.0 100.0 02:30:31 INFO - PROCESS | 8230 | 02:30:31 INFO - PROCESS | 8230 | [#5] imaging-gaussian-blur Cycles:10 Average:112.50 Median:113.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 02:30:31 INFO - PROCESS | 8230 | Values: 112.0 113.0 113.0 112.0 112.0 112.0 113.0 113.0 113.0 112.0 02:30:31 INFO - PROCESS | 8230 | 02:30:31 INFO - PROCESS | 8230 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.33 02:30:31 INFO - PROCESS | 8230 | Values: 145.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 02:30:31 INFO - PROCESS | 8230 | 02:30:31 INFO - PROCESS | 8230 | [#7] imaging-desaturate Cycles:10 Average:93.70 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 02:30:31 INFO - PROCESS | 8230 | Values: 94.0 94.0 94.0 94.0 95.0 93.0 93.0 94.0 93.0 93.0 02:30:31 INFO - PROCESS | 8230 | 02:30:31 INFO - PROCESS | 8230 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:1.32 (2.4%) stddev-sans-first:1.39 02:30:31 INFO - PROCESS | 8230 | Values: 55.0 54.0 55.0 53.0 54.0 57.0 56.0 55.0 53.0 56.0 02:30:31 INFO - PROCESS | 8230 | 02:30:31 INFO - PROCESS | 8230 | [#9] json-stringify-tinderbox Cycles:10 Average:52.50 Median:53.00 stddev:0.53 (1.0%) stddev-sans-first:0.53 02:30:31 INFO - PROCESS | 8230 | Values: 52.0 52.0 52.0 53.0 53.0 52.0 53.0 52.0 53.0 53.0 02:30:31 INFO - PROCESS | 8230 | 02:30:31 INFO - PROCESS | 8230 | [#10] stanford-crypto-aes Cycles:10 Average:78.90 Median:79.50 stddev:3.07 (3.9%) stddev-sans-first:3.26 02:30:31 INFO - PROCESS | 8230 | Values: 79.0 79.0 76.0 80.0 80.0 77.0 76.0 82.0 85.0 75.0 02:30:31 INFO - PROCESS | 8230 | 02:30:31 INFO - PROCESS | 8230 | [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:125.00 stddev:11.46 (9.2%) stddev-sans-first:12.05 02:30:31 INFO - PROCESS | 8230 | Values: 124.0 123.0 121.0 127.0 121.0 122.0 121.0 126.0 156.0 141.0 02:30:31 INFO - PROCESS | 8230 | 02:30:31 INFO - PROCESS | 8230 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.60 Median:160.00 stddev:3.10 (1.9%) stddev-sans-first:3.14 02:30:31 INFO - PROCESS | 8230 | Values: 157.0 155.0 164.0 160.0 164.0 162.0 157.0 157.0 160.0 160.0 02:30:31 INFO - PROCESS | 8230 | 02:30:31 INFO - PROCESS | 8230 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.50 Median:59.50 stddev:2.99 (5.0%) stddev-sans-first:3.12 02:30:31 INFO - PROCESS | 8230 | Values: 59.0 59.0 63.0 61.0 59.0 60.0 59.0 58.0 68.0 59.0 02:30:31 INFO - PROCESS | 8230 | -------- Summary: end -------- 02:30:31 INFO - PROCESS | 8230 | 02:30:32 INFO - TEST-INFO | 8230: exit 0 02:30:32 INFO - TEST-OK | kraken | took 59592ms 02:30:32 INFO - SUITE-END | took 1174s 02:30:32 INFO - Completed test suite (00:19:34) 02:30:32 INFO - javascript benchmark 02:30:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7842.516532955604, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3420.2646431017333, 3426.657334266572, 3455.378031954248, 3471.8437670304834, 3488.59881113672, 5663.490285874271, 5748.942510574893, 5763.798267060653, 5768.711564421777, 5769.278840144987, 5716.085426331788, 5753.165790960308, 5762.222100016496, 5763.682997435149, 5768.625039372438, 5069.695818250917, 5069.923951140736, 5108.310378098965, 5115.9744201278945, 5147.408048074463, 4954.232094025432, 4965.428975667808, 5162.483751624826, 5175.171972484403, 5208.817691380802, 5050.520200580939, 5085.389753229618, 5141.0489059523925, 5150.098732721777, 5166.121759300909, 5173.405058418292, 5176.404713457963, 5183.792648294064, 5186.740662966837, 5205.193195054772, 4862.854114376574, 5011.699298042093, 5080.339555857715, 5115.667481613683, 5132.204508301219, 5545.195946587763, 5564.4713752193475, 5631.4087020863035, 5671.149327600851, 5678.403767604384, 6084.908726369108, 6127.11156882254, 6133.509319254449, 6135.6625385603775, 6137.386261373871, 6170.413810687977, 6192.225971753531, 6195.597286176384, 6198.752049917998, 6199.132121502993, 5535.114381698949, 5581.05122129239, 5700.116481945263, 5726.541876649858, 5743.3395159557185, 6309.526785491106, 6310.337414571496, 6315.55791094619, 6315.715792789336, 6315.96842015787, 6040.0, 6086.391360863879, 6088.178095957078, 6101.969490152521, 6102.664353460514, 5846.41535846412, 5886.264216972879, 6025.3974602540275, 6049.848753781191, 6180.134781130645, 6093.908591371133, 6098.451139397475, 6107.389261073857, 6114.327423983358, 6123.877522449615, 5855.648661080349, 5903.911441328383, 5907.409259074144, 5912.17229587858, 6120.6299886969155, 4654.464736555339, 4659.114768194032, 4688.601468875184, 4688.929666055012, 4704.95295047052, 4240.554741752133, 4249.107687385622, 4249.97875010623, 4267.4025636410925, 4297.763623000703, 5646.858828529237, 5670.631408958487, 5816.651000939873, 5817.7382017809305, 5828.79599214034, 6161.353057928853, 6223.0, 6238.376162383725, 6239.06414037898, 6243.094751261133, 5914.0, 5920.0, 5927.170196172539, 5928.288605367384, 5954.732037058343, 5055.494450554915, 5098.745062746922, 5203.453637368022, 5245.842624721265, 5266.78932842682, 6512.479001679854, 6536.509761767791, 6540.6729663516635, 6544.214694236817, 6545.443637290884, 6135.233095863017, 6137.539684523589, 6180.4746596538, 6190.350013248544, 6194.938050619436, 6160.938390616216, 6200.441960223601, 6346.936530634819, 6544.869102617826, 6558.147440832661, 6119.746288422794, 6128.019516877278, 6128.625347140905, 6129.14485165794, 6134.294556126102, 6188.504919606331, 6200.596961197508, 6201.255849298113, 6206.937930620636, 6210.31686514474, 5643.548516118783, 5742.856428589319, 6036.969815151072, 6042.1540984261355, 6045.776013846276, 5905.498032667099, 5940.316863560746, 6028.819135425944, 6033.607815491979, 6043.8186854394435, 5949.940500594938, 5984.850378740566, 5992.310884248367, 5992.610480318765, 5998.670073146019, 5710.457506536873, 5722.74247658848, 5766.682832444256, 5769.105788602773, 6033.818985430444, 5822.563307752021, 5828.970855145697, 5843.328017278068, 5862.560307977004, 5865.882682346244], "value": 5637.702126124693, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [775.2557544757033, 836.05943313772, 857.3227150551065, 911.9042500537439, 919.5034681272114, 30963.380732385365, 44651.33023004657, 45635.54364456354, 45781.31328030078, 45815.312770308476, 41907.58092419075, 42199.789001055025, 42255.154896902044, 46217.537824621744, 46292.53707462925, 7861.410394220427, 8023.879641805378, 9237.676681316156, 9363.812723745521, 9366.765830854216, 10821.0, 11047.116230701524, 11048.779024419508, 11058.723531911726, 11377.829332560019, 11033.227674062819, 11037.0, 11074.114070874311, 11075.0, 11081.168912331566, 11023.338599683964, 11044.171687123458, 11061.336319820837, 11074.667759967213, 11075.667729968034, 10814.297070690458, 10847.891521084846, 10878.72803179919, 10880.347179169275, 10884.346939183675, 44020.11959760819, 44063.55936440659, 44190.33714494285, 44216.55783442189, 44331.33502997458, 4193.496780386373, 4265.808038638269, 4331.826726930919, 4449.4660640723, 4499.370088187657, 30223.848880755675, 30887.691123088705, 30897.536536951964, 31114.377712445625, 31633.84183079093, 4279.550647182032, 4324.545922678137, 4337.132573485315, 4340.978295108504, 4393.890152746175, 234715.0, 235297.0, 235840.0, 237006.99999999828, 237273.0, 53474.73262633662, 53582.0, 53681.46318536765, 53704.0, 53808.19287710688, 56275.0, 56834.7158264206, 56881.431185687616, 56896.431035689115, 56959.71520142373, 16706.4152754653, 17033.148342582823, 17083.658326833392, 17117.400890968755, 17191.484255472355, 11386.202965792481, 11592.304461732323, 14765.0, 15013.699726005638, 15019.624509387353, 14202.289885505683, 14324.355404006845, 14391.640208994859, 14418.639534011734, 14437.133771973715, 5725.370209276976, 5729.627574207663, 5786.88426231473, 5795.275590551181, 5847.26909136358, 1016.9593216271414, 1017.760826205841, 1018.6078359831519, 1019.6686077024997, 1031.9226058045676, 28390.290242744097, 28394.148175554765, 28545.71454285472, 28701.85649071783, 28862.0, 1061.0874647802884, 1070.8768491623564, 1071.052118874786, 1106.811841986848, 1108.3239224073309, 15062.849371506363, 15265.847341526665, 15284.923575382052, 15380.846191537941, 15399.846001539841, 289605.0, 290432.0, 291191.0, 291736.0, 291989.0, 56656.0, 56829.431705683244, 56922.0, 57040.42959570434, 57042.0, 1473.1087691946218, 1487.4050379847931, 1496.0649594003748, 1504.601280660626, 1560.8683704314508, 28205.57691634586, 28477.288067797643, 28965.0, 29500.11499655014, 29740.553891692074, 36752.816235918646, 36940.0, 36942.0, 36953.815230923676, 36954.0, 292871.0, 293569.0, 293721.0, 293888.0, 448477.0, 25489.617655734808, 25866.09468668663, 25888.352791180372, 29681.406371872872, 30576.541351880183, 40052.39921401123, 40306.1938761229, 40326.1934761309, 40360.59639403568, 40598.39102413407, 31752.523712144797, 31968.36063278768, 32081.19797005, 32261.677383226805, 32599.837000814845, 30829.845850770602, 31241.68758312388, 31353.372932540766, 31459.37081258316, 31467.685323146474, 35243.95547269016, 35441.46837797487, 35726.0, 35918.28163436769, 36389.63610363862, 30013.69986300109, 30205.0, 30288.69711302947, 30420.23949401194, 30705.0, 23804.761952380253, 24450.388740281636, 24452.388690282885, 24722.25833225006, 25113.74886251114], "value": 18907.288569442306, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [469.8989717210799, 473.5312041079328, 478.57645983304764, 479.1590758219327, 493.2157868988309, 20101.59796804065, 22061.0, 22975.77024229757, 23082.538349233004, 23333.300000999996, 22222.222222222226, 22531.54936901261, 22947.885260573672, 22955.08179672811, 23144.42138946527, 6716.865662686743, 6776.085228494139, 6922.48081393895, 6962.930370696305, 6971.79084627462, 6914.274001229874, 7028.086348774652, 7285.0, 7583.962080189592, 7601.429892758038, 7167.569945803242, 7755.224477552228, 7762.184970578092, 7764.883526747103, 7770.222977702241, 7488.850222995537, 7573.318401343878, 7594.354479869217, 7595.240475952416, 7595.924040759577, 7182.06633137694, 7340.632968351614, 7394.408447324255, 7400.185979542246, 7400.70397184112, 23938.40153996164, 24283.27150185497, 24841.751582484307, 25527.361815954562, 26445.3388665283, 3104.7671424643017, 3166.904992850218, 3209.903702888917, 3225.3710526447353, 3276.2300859298048, 15918.920405398014, 16040.0, 16050.0, 16215.189240537926, 16334.264958076916, 2189.189999700105, 2280.9543809123725, 2289.427643089228, 2326.4183954011496, 2337.4506990857135, 107512.0, 108858.45570772175, 108959.45520272428, 109541.0, 109921.45039274833, 17647.205875735624, 17899.552511187063, 18298.25526171085, 18387.72418413725, 18638.627227455374, 31066.378672426876, 31091.689083109333, 31140.22149446282, 31394.529082063786, 31457.370852583277, 10637.361758294526, 10759.462026898624, 10806.837897431546, 10875.0, 10914.945425272823, 9189.264858811279, 9218.124278193694, 9235.353525253302, 9261.0, 9410.106039926197, 9131.269498440242, 9428.0, 9474.763130921645, 9488.762780930532, 9504.809903801885, 3641.6358364163902, 3760.5863355030924, 3948.565657777642, 3954.915166170392, 3956.8615098471414, 954.231843366097, 967.0716112531908, 971.6356366362614, 992.161623428202, 994.5673631969971, 19655.0, 20926.895365523076, 21330.360089197347, 21407.46481337948, 21527.33014535781, 965.5992763003416, 975.8292298847673, 979.3585201692903, 985.9950700246596, 986.7286496213599, 11246.931541503707, 11790.469428875549, 11899.762004759856, 11956.0, 12100.33448160342, 590066.0, 619889.0, 623405.0, 626414.0, 632196.0, 70923.2907670927, 72191.63904180446, 75245.24754752492, 81765.0, 104186.47906760417, 1225.4694056772735, 1255.805350170725, 1268.4165283969478, 1268.7843066678686, 1270.6442196185083, 18246.817531824512, 18434.63130737351, 18740.90629546898, 18912.905435472734, 18934.43196704101, 44634.77682611566, 44861.0, 45180.322295164944, 45285.0, 45297.54702452933, 63770.36229637644, 63893.0, 64315.0, 64694.0, 65825.34174658384, 12179.08656850722, 12339.13626046168, 12339.568115115928, 12385.380730963596, 12440.564580239648, 13940.930295348458, 13998.090124141898, 14061.086029408056, 14265.286735663383, 14339.139651620937, 6400.967995159995, 11151.0, 11479.36863472517, 12059.336736479578, 12386.81419778686, 10499.212559057949, 10811.729706757395, 11360.715982100513, 11659.766804664028, 11855.229410088317, 6137.232845894263, 11563.364014979257, 12192.87807121953, 12194.390280486117, 12331.876681233072, 12500.00000000016, 12523.874761252271, 12533.310667913353, 12644.114911956074, 12778.169418987736, 11476.483558240066, 11846.407679615812, 11945.283283003047, 12027.398630068637, 12324.0], "value": 11346.734045398942, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1459.6642772162395, 1573.3470609696974, 1587.6110352963526, 1630.8124565674943, 1636.909969951653, 9657.855132173014, 11083.168762342826, 11444.084473242141, 11454.083673306137, 11474.254173478728, 11489.885101149006, 11530.942345288282, 11559.0, 11562.826557601622, 11575.768484630324, 2028.98985505073, 2092.926747563828, 2370.9644355334685, 2407.4703565215623, 2408.3136306152664, 2466.839655422392, 2528.266802627236, 2534.9239522814346, 2539.225536211464, 2540.923772286825, 2455.4475243070256, 2473.985665876991, 2479.7396273391305, 2481.565725997943, 2483.379155211197, 2434.245383930987, 2448.485817978209, 2466.0628960994795, 2472.8392654477493, 2473.51766405551, 2329.7553756855623, 2383.3088404362716, 2384.952300953971, 2387.164492427654, 2389.6057150570136, 11493.770124597544, 11766.11754118436, 11779.0, 11782.175247732663, 11789.646310610695, 5845.064789633639, 5971.880562388771, 5972.492338151263, 5979.342272350038, 5979.880402391971, 3483.860645574174, 3485.268093700326, 3559.928801423983, 3596.1369271374683, 3652.7808331500196, 1348.9055766096378, 1379.3585982518077, 1396.2809153286066, 1417.5322143692556, 1436.3177490691942, 16756.832431675648, 16891.915540422342, 16901.0, 17105.657886842317, 17142.05718685472, 4872.78072486739, 4897.1185186666025, 4991.900161996739, 4992.675476094042, 5078.035173317058, 14222.644433889029, 14229.64425889361, 14231.07498012626, 14253.857461425461, 14262.215578143094, 6074.088886667036, 6078.75684972605, 6092.72582733778, 6093.390660933871, 6098.695065246809, 5347.465253474621, 5533.612647114744, 5564.109742441271, 5599.832005039855, 5609.0184217761725, 4363.716358436692, 4452.9554704453185, 4464.441944756905, 4508.571685689854, 4513.435820522434, 1179.33367647279, 1194.6798787340038, 1208.4984731336397, 1213.1023042948332, 1218.3786269002871, 892.3262936482914, 931.8695382646434, 948.6205517792938, 951.039450155348, 955.1880901234034, 6901.516893817485, 6912.827179320558, 6954.478414118961, 7036.226015138331, 7081.92918070823, 1049.338916482611, 1054.8734151901822, 1071.5338827610015, 1085.2620218251664, 1085.9891401086047, 4606.746628935373, 4635.165670179333, 4637.211674015425, 4720.244760838249, 4813.205821039559, 13714.588562343146, 14429.494967676292, 14474.131552106906, 14485.203313817841, 14494.855051449562, 13897.930510347383, 14322.14067155974, 14416.855831441551, 14978.325975331136, 14980.550583482513, 10644.787104258026, 10839.349639021684, 10840.078593319498, 10848.78302433947, 10876.836847447295, 7399.704011839466, 7620.695172193272, 7632.656530456254, 7652.005239318853, 7843.8039049021945, 12775.55285565038, 13019.33258223076, 13055.869441305846, 13078.084534082524, 13315.66710832237, 10476.895231047592, 13109.410076546388, 13179.538716145273, 13275.336233188109, 13293.20240785556, 9911.900880991097, 10026.849597256192, 10107.949460252652, 10132.240081993732, 10251.487425628839, 10938.835917461403, 10956.890431095906, 11029.669109926715, 11042.171837112088, 11048.558057677603, 9440.527973601154, 9493.05069493045, 9545.236381089357, 9583.568739406604, 9649.855252171363, 9177.77055573616, 9238.491882946233, 9269.907300926905, 9330.813383732424, 9457.668981585612, 7971.641276142704, 8072.798180045545, 8202.056763472277, 8210.63052162642, 8212.0, 6705.798826035227, 6778.966105169443, 6794.252632210354, 6819.079424277659, 6860.451163906975, 6716.227633821977, 6719.630420326929, 6892.172939247323, 6957.478189135733, 6997.475189360716], "value": 5493.154199469696, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.2980976104069, 429.48032880214936, 444.72427095200976, 455.6195576693461, 457.2775015475548, 5184.53339199472, 5222.9477705222935, 5242.737863106844, 5252.238425428311, 5254.842354729355, 5032.874178145548, 5130.666506677073, 5139.820106296281, 5159.3808742950805, 5161.741912904358, 4335.783210839461, 4336.701548179454, 4348.999460248289, 4351.325544540601, 4381.671374646899, 4347.847825326115, 4354.564543545652, 4368.126374725051, 4371.229651990949, 4378.6715996300245, 4213.7893105344765, 4265.87202383929, 4338.978305108486, 4355.825766969318, 4358.6077253047215, 4272.530021697611, 4296.978515107405, 4346.783140598286, 4347.500037495681, 4350.0, 4051.97974010131, 4064.735792173529, 4104.281750693616, 4108.281050816096, 4151.83392664293, 5029.84910452687, 5064.82273120439, 5103.744812759384, 5130.4356520782685, 5134.64057515974, 5044.722540260284, 5051.116054690451, 5075.426617748473, 5079.517445842639, 5086.567641750418, 5358.892822143574, 5423.7830486780485, 5429.53848922842, 5432.619716619838, 5442.156465747816, 4466.285394336923, 4487.816571859475, 4543.727376357429, 4543.863684089482, 4569.543045695437, 5429.886873190986, 5544.696996205888, 5584.720763961826, 5630.887382252332, 5650.802221922213, 4686.882827929261, 4688.2030054890065, 4692.694974826625, 4722.220833562493, 4736.171170045228, 4592.586667199968, 4600.2869555218995, 4628.467726211529, 4809.134355815987, 4845.442774080955, 4987.80048798044, 5039.143345631252, 5052.823151189691, 5070.670406423571, 5095.490450954949, 5447.291852059287, 5447.863803404946, 5461.617686761889, 5477.260569823023, 5511.255980442669, 1575.8030246219223, 1631.0947424179458, 1639.6146905477203, 1645.3007471824667, 1648.3406637345158, 1247.1394737631006, 1269.800038963171, 1272.9370975235781, 1283.6277479530831, 1301.1347453943022, 5349.004557447842, 5395.785948161711, 5400.540954018952, 5428.945710542923, 5441.238226648194, 5584.5811564132855, 5625.8593535161945, 5635.5347609621795, 5638.238837756932, 5647.6329038613185, 5206.672298563918, 5312.362516497968, 5340.279062326614, 5368.32895888014, 5394.487523685244, 2896.2759310172455, 2937.3831495386207, 2944.0275015739508, 2949.4985852405143, 2958.704129587024, 5657.264555607745, 5876.970615146897, 5915.792947246826, 5921.0, 5947.542852001201, 5698.17376480408, 5708.257926469532, 5723.484886360247, 5723.627964182315, 5764.481196692318, 5837.357890632027, 5869.325027621878, 5936.426846885579, 5958.880822383615, 5969.52243820502, 5307.734613269244, 5623.943760562342, 5642.435756424489, 5692.800751973661, 5718.3423906249645, 5286.312779338815, 5373.758180881948, 5411.728243862611, 5524.779008839762, 5564.4991950724625, 5836.795712150224, 5895.498882594856, 5899.410058994066, 5900.409959004065, 5944.1975333331175, 4545.886352841073, 4642.651801114997, 4756.6908150970075, 4758.119747846659, 4759.7858096386435, 5546.3638226722405, 5568.972155139199, 5584.525315348241, 5607.383187849252, 5638.37977822431, 5466.644668096561, 5474.753636086465, 5479.260369815092, 5527.364353099445, 5529.889402211853, 5346.348676651338, 5454.4545545445135, 5491.478309560585, 5505.091659876076, 5527.419620939743, 5419.374187743582, 5479.315085614298, 5485.0, 5508.394076651645, 5534.367361628249, 5497.47773961473, 5517.834464965897, 5524.33707955048, 5539.947409992089, 5555.583331250092, 5178.171492561323, 5351.812686555952, 5372.355317361941, 5391.353037635509, 5394.277948215718], "value": 4415.539524404199, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [843.2916350265775, 904.3850181876323, 904.7602385367877, 934.3272843552649, 936.7002559181061, 16417.83582164178, 16428.342866285348, 17152.48542543724, 17500.299988000497, 17667.381641642543, 16760.078195699232, 17222.0, 17722.911385443087, 17850.28598856044, 17866.285348586072, 900.774806298427, 920.4155361345561, 923.1829830599934, 923.6536298887917, 924.0620769918538, 872.2585802068255, 901.292485398962, 909.2044461096541, 910.3854897943894, 910.4855756497558, 956.4739393333673, 959.1080295325345, 959.122403001253, 959.2853324273426, 960.2366118935463, 955.1356022799343, 957.2150836314225, 957.4398976598698, 957.7414098193484, 957.8323793336139, 705.1855107350966, 705.9011738356634, 707.5436343558428, 707.6002058836741, 707.780588017711, 16431.753523697036, 16590.83409165905, 16907.0, 17473.912630436767, 17478.300867965267, 15845.68308633821, 16112.0, 16236.83763162365, 16424.09667468289, 16604.916975415046, 13141.948644108448, 13330.73338533224, 13357.13178643385, 13525.120867143603, 13549.254790986492, 3953.5453422856162, 4001.2597669430957, 4031.314676505001, 4063.817128229237, 4111.321631930728, 83776.0, 84134.57932710358, 85784.0, 86695.0, 87221.56389218077, 11909.589546104573, 11921.34432606215, 12020.579279725343, 12048.457819397972, 12250.693732656577, 23710.17014404522, 24011.7598824013, 24023.0, 24121.879390603284, 24234.0, 8318.8336233275, 8339.291160251447, 8545.060043395222, 8561.828763424697, 8563.0, 4729.716217026989, 4806.431182457847, 4833.081714474239, 4891.997140586172, 4925.359703238628, 3658.432942893856, 3734.10381508436, 3740.7381483296454, 3775.679067279312, 3859.9421008684894, 633.5090305013651, 642.82322361351, 644.7453255963868, 656.9605823650596, 666.9299723528959, 681.5535824035264, 683.1392445518683, 704.8907419350008, 709.5529816215854, 712.3410844968383, 11499.367534785668, 11755.764884702428, 12313.26120432777, 12428.316442595744, 12741.235525868478, 825.793551612097, 848.1772680499905, 853.833502467013, 871.9564021799011, 874.4490970688553, 5439.238506609078, 5631.2397826293745, 5678.432156784289, 5777.422257774189, 5778.508826749773, 82077.76883346755, 82961.58519207485, 85140.57429712935, 85752.14247857567, 87122.0, 42187.36718949218, 44648.553514465086, 50258.0, 58555.41444585585, 73873.26126738664, 55213.0, 59997.400026000054, 60655.0, 61033.0, 62159.68920155461, 11394.601188958346, 11684.889935456118, 11712.531498739954, 11890.524379025088, 12055.758884822078, 42270.78864605657, 42487.93780155521, 42727.0, 43778.78110609426, 43928.56071439245, 47078.293825593326, 47526.52473475221, 48108.27837582369, 49532.75233623809, 49905.750471248866, 12883.776041276064, 13069.607911762663, 13102.672433189247, 13243.337833108499, 13295.135816171918, 16013.599660008593, 16394.344226230816, 16455.67088658196, 16522.17389130563, 16584.83415165881, 15492.922535387252, 15695.764563531327, 15725.135117568643, 15773.605659858595, 16258.349666013228, 15993.8400615997, 16430.955029397668, 17261.136943153044, 17641.117944103, 18113.45659630213, 16576.336946522486, 16682.249298781826, 17727.911360443115, 17874.5531361717, 18055.638887222445, 11054.22620416563, 11080.889191107986, 11532.654020379403, 12103.75792484163, 12496.06279529057, 13393.727595878376, 13537.864621353661, 13793.448262069805, 13854.861451385761, 14079.436822526985], "value": 7930.2457915620535, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1447.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 110.0, 110.0, 112.0, 111.0, 112.0, 110.0, 110.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 116.0, 115.0, 152.0, 116.0, 116.0, 115.0, 115.0, 135.0, 116.0], "value": 123.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 159.0, 160.0, 158.0, 160.0, 159.0, 160.0, 159.0], "value": 159.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 104.0, 75.0, 75.0, 75.0, 76.0, 102.0, 77.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 102.0, 82.0, 82.0, 82.0, 97.0, 82.0, 82.0, 100.0], "value": 87.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 113.0, 112.0, 112.0, 112.0, 113.0, 113.0, 113.0, 112.0], "value": 112.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 95.0, 93.0, 93.0, 94.0, 93.0, 93.0], "value": 93.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 53.0, 54.0, 57.0, 56.0, 55.0, 53.0, 56.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 53.0, 53.0, 52.0, 53.0, 52.0, 53.0, 53.0], "value": 52.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 76.0, 80.0, 80.0, 77.0, 76.0, 82.0, 85.0, 75.0], "value": 78.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 123.0, 121.0, 127.0, 121.0, 122.0, 121.0, 126.0, 156.0, 141.0], "value": 128.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 155.0, 164.0, 160.0, 164.0, 162.0, 157.0, 157.0, 160.0, 160.0], "value": 159.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 63.0, 61.0, 59.0, 60.0, 59.0, 58.0, 68.0, 59.0], "value": 60.5, "unit": "score"}]}]} 02:30:32 INFO - Return code: 0 02:30:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:30:32 INFO - # TBPL SUCCESS # 02:30:32 INFO - Running post-action listener: _resource_record_post_action 02:30:32 INFO - [mozharness: 2017-06-08 09:30:32.750776Z] Finished run-tests step (success) 02:30:32 INFO - Running post-run listener: _resource_record_post_run 02:30:32 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 917504; Write bytes: 326975488; Read time: 124; Write time: 228164 02:30:32 INFO - TinderboxPrint: CPU usage
13.1% 02:30:32 INFO - TinderboxPrint: I/O read bytes / time
917,504 / 124 02:30:32 INFO - TinderboxPrint: I/O write bytes / time
326,975,488 / 228,164 02:30:32 INFO - TinderboxPrint: CPU idle
8,248.3 (86.9%) 02:30:32 INFO - TinderboxPrint: CPU user
1,196.5 (12.6%) 02:30:32 INFO - TinderboxPrint: Swap in / out
0 / 0 02:30:32 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 77885440; Read time: 0; Write time: 51448 02:30:32 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 917504; Write bytes: 227487744; Read time: 124; Write time: 125936 02:30:33 INFO - Running post-run listener: _upload_blobber_files 02:30:33 INFO - Blob upload gear active. 02:30:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:30:33 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:30:33 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:30:33 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:30:33 INFO - (blobuploader) - INFO - Open directory for files ... 02:30:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:30:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:30:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:30:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:30:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:30:34 INFO - (blobuploader) - INFO - Done attempting. 02:30:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:30:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:30:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:30:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:30:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:30:35 INFO - (blobuploader) - INFO - Done attempting. 02:30:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:30:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:30:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:30:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:30:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:30:36 INFO - (blobuploader) - INFO - Done attempting. 02:30:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:30:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:30:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:30:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:30:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:30:43 INFO - (blobuploader) - INFO - Done attempting. 02:30:43 INFO - (blobuploader) - INFO - Iteration through files over. 02:30:43 INFO - Return code: 0 02:30:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:30:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:30:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/bede5a5b31765baa230792f7746805a84cba3fbcf27ca153228b2e5efa2f16dbb7c549dba3238cf191acb83d73d275e3299db68c2245fb5a49219f5ef43901b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0c88f69548579c8cb14ebb4bc2af10d5a1fdb541ccc7f386d3ba7126a52a8ee1a342d4a6ab947f28368bd428681fd6db6be8d343063539671114cd79032dec43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/22efafadeb33cb0b3472bab95d112697eaaf977a16a0ff64869098dbdba5589ed27b1975d0bd2304e1296fc9ccd43a0f4e64807994192ca6d2e3dd9ea280bd54", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5ca0ff0604fc6d8e059a5c7dc4db0ae44deda39dc6546597d7a272858dbebea729a5bd1a37e6cdbc7c2b59a59c82452125da8863106e5250f78e8a55afe466a4"} 02:30:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:30:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:30:43 INFO - Contents: 02:30:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/bede5a5b31765baa230792f7746805a84cba3fbcf27ca153228b2e5efa2f16dbb7c549dba3238cf191acb83d73d275e3299db68c2245fb5a49219f5ef43901b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0c88f69548579c8cb14ebb4bc2af10d5a1fdb541ccc7f386d3ba7126a52a8ee1a342d4a6ab947f28368bd428681fd6db6be8d343063539671114cd79032dec43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/22efafadeb33cb0b3472bab95d112697eaaf977a16a0ff64869098dbdba5589ed27b1975d0bd2304e1296fc9ccd43a0f4e64807994192ca6d2e3dd9ea280bd54", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5ca0ff0604fc6d8e059a5c7dc4db0ae44deda39dc6546597d7a272858dbebea729a5bd1a37e6cdbc7c2b59a59c82452125da8863106e5250f78e8a55afe466a4"} 02:30:43 INFO - Running post-run listener: copy_logs_to_upload_dir 02:30:43 INFO - Copying logs to upload dir... 02:30:43 INFO - mkdir: /builds/slave/test/build/upload/logs 02:30:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.302470 ========= master_lag: 0.54 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-06-08 02:30:42.958803) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-08 02:30:42.963356) ========= 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=17051fcd5208b27b50bedfeb000001dd-1496910229.93506-1865388782 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/bede5a5b31765baa230792f7746805a84cba3fbcf27ca153228b2e5efa2f16dbb7c549dba3238cf191acb83d73d275e3299db68c2245fb5a49219f5ef43901b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0c88f69548579c8cb14ebb4bc2af10d5a1fdb541ccc7f386d3ba7126a52a8ee1a342d4a6ab947f28368bd428681fd6db6be8d343063539671114cd79032dec43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/22efafadeb33cb0b3472bab95d112697eaaf977a16a0ff64869098dbdba5589ed27b1975d0bd2304e1296fc9ccd43a0f4e64807994192ca6d2e3dd9ea280bd54", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5ca0ff0604fc6d8e059a5c7dc4db0ae44deda39dc6546597d7a272858dbebea729a5bd1a37e6cdbc7c2b59a59c82452125da8863106e5250f78e8a55afe466a4"} build_url:https://queue.taskcluster.net/v1/task/ayb1ueBDQpiGE29cznG40w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011260 build_url: 'https://queue.taskcluster.net/v1/task/ayb1ueBDQpiGE29cznG40w/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/bede5a5b31765baa230792f7746805a84cba3fbcf27ca153228b2e5efa2f16dbb7c549dba3238cf191acb83d73d275e3299db68c2245fb5a49219f5ef43901b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0c88f69548579c8cb14ebb4bc2af10d5a1fdb541ccc7f386d3ba7126a52a8ee1a342d4a6ab947f28368bd428681fd6db6be8d343063539671114cd79032dec43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/22efafadeb33cb0b3472bab95d112697eaaf977a16a0ff64869098dbdba5589ed27b1975d0bd2304e1296fc9ccd43a0f4e64807994192ca6d2e3dd9ea280bd54", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5ca0ff0604fc6d8e059a5c7dc4db0ae44deda39dc6546597d7a272858dbebea729a5bd1a37e6cdbc7c2b59a59c82452125da8863106e5250f78e8a55afe466a4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-08 02:30:42.987843) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 02:30:42.991286) ========= 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=17051fcd5208b27b50bedfeb000001dd-1496910229.93506-1865388782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004368 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 02:30:43.072861) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-08 02:30:43.073240) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-08 02:30:43.073615) ========= ========= Total master_lag: 0.69 =========