builder: mozilla-beta_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-087 starttime: 1494960442.11 results: success (0) revision: 925160e8379600a79d869cf18df4f158e7eb1868 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-16 11:47:22.113822) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-16 11:47:22.114309) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-16 11:47:22.114622) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-16 11:47:22.153167) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 11:47:22.153560) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1494959897.738146-2023400927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-16 11:47:22-- 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% 42.2M=0s 2017-05-16 11:47:22 (42.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.152788 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 11:47:22.320953) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 11:47:22.321471) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1494959897.738146-2023400927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015261 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 11:47:22.370996) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 11:47:22.371360) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 925160e8379600a79d869cf18df4f158e7eb1868 --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 925160e8379600a79d869cf18df4f158e7eb1868 --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=ca619d3d7d62c99d832f7b8a000001c4-1494959897.738146-2023400927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-16 11:47:23,003 truncating revision to first 12 chars 2017-05-16 11:47:23,003 Setting DEBUG logging. 2017-05-16 11:47:23,003 attempt 1/10 2017-05-16 11:47:23,003 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/925160e83796?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-16 11:47:23,346 unpacking tar archive at: mozilla-beta-925160e83796/testing/mozharness/ program finished with exit code 0 elapsedTime=0.716924 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 11:47:23.104970) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-16 11:47:23.105784) ========= script_repo_revision: 925160e8379600a79d869cf18df4f158e7eb1868 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-16 11:47:23.106742) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-16 11:47:23.107455) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-16 11:47:23.118661) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-05-16 11:47:23.118975) ========= /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=ca619d3d7d62c99d832f7b8a000001c4-1494959897.738146-2023400927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:47:23 INFO - MultiFileLogger online at 20170516 11:47:23 in /builds/slave/test 11:47:23 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 11:47:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:47:23 INFO - {'append_to_log': False, 11:47:23 INFO - 'base_work_dir': '/builds/slave/test', 11:47:23 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 11:47:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:47:23 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 11:47:23 INFO - 'buildbot_json_path': 'buildprops.json', 11:47:23 INFO - 'config_files': ('talos/linux_config.py',), 11:47:23 INFO - 'default_actions': ('clobber', 11:47:23 INFO - 'read-buildbot-config', 11:47:23 INFO - 'download-and-extract', 11:47:23 INFO - 'populate-webroot', 11:47:23 INFO - 'create-virtualenv', 11:47:23 INFO - 'install', 11:47:23 INFO - 'run-tests'), 11:47:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:47:23 INFO - 'download_minidump_stackwalk': True, 11:47:23 INFO - 'download_symbols': 'ondemand', 11:47:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:47:23 INFO - 'tooltool.py': '/tools/tooltool.py', 11:47:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:47:23 INFO - '/tools/misc-python/virtualenv.py')}, 11:47:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:47:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:47:23 INFO - 'gecko_profile': False, 11:47:23 INFO - 'gecko_profile_interval': 0, 11:47:23 INFO - 'installer_path': 'installer.exe', 11:47:23 INFO - 'log_level': 'info', 11:47:23 INFO - 'log_name': 'talos', 11:47:23 INFO - 'log_to_console': True, 11:47:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:47:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:47:23 INFO - 'opt_config_files': (), 11:47:23 INFO - 'pip_index': False, 11:47:23 INFO - 'suite': 'dromaeojs', 11:47:23 INFO - 'system_bits': '32', 11:47:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:47:23 INFO - 'title': 'talos-linux64-ix-087', 11:47:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:47:23 INFO - 'use_talos_json': True, 11:47:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:47:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:47:23 INFO - 'work_dir': 'build'} 11:47:23 INFO - [mozharness: 2017-05-16 18:47:23.849346Z] Running clobber step. 11:47:23 INFO - Running pre-action listener: _resource_record_pre_action 11:47:23 INFO - Running main action method: clobber 11:47:23 INFO - rmtree: /builds/slave/test/build 11:47:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:47:25 INFO - Running post-action listener: _resource_record_post_action 11:47:25 INFO - [mozharness: 2017-05-16 18:47:25.372145Z] Finished clobber step (success) 11:47:25 INFO - [mozharness: 2017-05-16 18:47:25.372243Z] Running read-buildbot-config step. 11:47:25 INFO - Running pre-action listener: _resource_record_pre_action 11:47:25 INFO - Running main action method: read_buildbot_config 11:47:25 INFO - Using buildbot properties: 11:47:25 INFO - { 11:47:25 INFO - "project": "", 11:47:25 INFO - "product": "firefox", 11:47:25 INFO - "who": "ffxbld@noreply.mozilla.org", 11:47:25 INFO - "installer_path": "public/build/target.tar.bz2", 11:47:25 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 11:47:25 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta/", 11:47:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs", 11:47:25 INFO - "stage_platform": "linux64", 11:47:25 INFO - "basedir": "/builds/slave/test", 11:47:25 INFO - "buildnumber": 47, 11:47:25 INFO - "platform": "ubuntu64_hw", 11:47:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:47:25 INFO - "slavebuilddir": "test", 11:47:25 INFO - "taskId": "aeyV5v1dQAu4juhOfBrgVw", 11:47:25 INFO - "branch": "mozilla-beta", 11:47:25 INFO - "script_repo_revision": "production", 11:47:25 INFO - "revision": "925160e8379600a79d869cf18df4f158e7eb1868", 11:47:25 INFO - "slavename": "talos-linux64-ix-087", 11:47:25 INFO - "repo_path": "releases/mozilla-beta" 11:47:25 INFO - } 11:47:25 INFO - Finding installer, test and symbols from parent task. 11:47:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aeyV5v1dQAu4juhOfBrgVw'}, attempt #1 11:47:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aeyV5v1dQAu4juhOfBrgVw'}, attempt #1 11:47:26 INFO - Task dependencies: dvjEDvQKTyG_CQ-TmrKAvA 11:47:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dvjEDvQKTyG_CQ-TmrKAvA'}, attempt #1 11:47:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/dvjEDvQKTyG_CQ-TmrKAvA/artifacts/public/build/target.tar.bz2 11:47:26 INFO - Set test_url: https://queue.taskcluster.net/v1/task/dvjEDvQKTyG_CQ-TmrKAvA/artifacts/public/build/test_packages.json 11:47:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/dvjEDvQKTyG_CQ-TmrKAvA/artifacts/public/build/target.crashreporter-symbols.zip 11:47:26 INFO - Running post-action listener: _resource_record_post_action 11:47:26 INFO - [mozharness: 2017-05-16 18:47:26.789722Z] Finished read-buildbot-config step (success) 11:47:26 INFO - [mozharness: 2017-05-16 18:47:26.789942Z] Running download-and-extract step. 11:47:26 INFO - Running pre-action listener: _resource_record_pre_action 11:47:26 INFO - Running main action method: download_and_extract 11:47:26 INFO - mkdir: /builds/slave/test/build/tests 11:47:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:26 INFO - trying https://queue.taskcluster.net/v1/task/dvjEDvQKTyG_CQ-TmrKAvA/artifacts/public/build/target.test_packages.json 11:47:26 INFO - Downloading https://queue.taskcluster.net/v1/task/dvjEDvQKTyG_CQ-TmrKAvA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:47:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dvjEDvQKTyG_CQ-TmrKAvA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:47:27 INFO - Downloaded 986 bytes. 11:47:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:47:27 INFO - Using the following test package requirements: 11:47:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:47:27 INFO - u'common': [u'target.common.tests.zip'], 11:47:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:47:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:47:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:47:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:47:27 INFO - u'mozbase': [u'target.common.tests.zip'], 11:47:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:47:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:47:27 INFO - u'web-platform': [u'target.common.tests.zip', 11:47:27 INFO - u'target.web-platform.tests.zip'], 11:47:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:47:27 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:47:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dvjEDvQKTyG_CQ-TmrKAvA/artifacts/public/build/target.common.tests.zip 11:47:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dvjEDvQKTyG_CQ-TmrKAvA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:47:27 INFO - Fetch https://queue.taskcluster.net/v1/task/dvjEDvQKTyG_CQ-TmrKAvA/artifacts/public/build/target.common.tests.zip into memory 11:47:29 INFO - Expected file size: 59542536 11:47:29 INFO - Obtained file size: 59542536 11:47:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:47:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dvjEDvQKTyG_CQ-TmrKAvA/artifacts/public/build/target.common.tests.zip 11:47:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dvjEDvQKTyG_CQ-TmrKAvA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:47:39 INFO - Fetch https://queue.taskcluster.net/v1/task/dvjEDvQKTyG_CQ-TmrKAvA/artifacts/public/build/target.common.tests.zip into memory 11:47:41 INFO - Expected file size: 59542536 11:47:41 INFO - Obtained file size: 59542536 11:47:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dvjEDvQKTyG_CQ-TmrKAvA/artifacts/public/build/target.talos.tests.zip 11:47:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dvjEDvQKTyG_CQ-TmrKAvA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:47:52 INFO - Fetch https://queue.taskcluster.net/v1/task/dvjEDvQKTyG_CQ-TmrKAvA/artifacts/public/build/target.talos.tests.zip into memory 11:47:52 INFO - Expected file size: 14404449 11:47:52 INFO - Obtained file size: 14404449 11:47:53 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')]} 11:47:53 INFO - trying https://queue.taskcluster.net/v1/task/dvjEDvQKTyG_CQ-TmrKAvA/artifacts/public/build/target.tar.bz2 11:47:53 INFO - Downloading https://queue.taskcluster.net/v1/task/dvjEDvQKTyG_CQ-TmrKAvA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:47:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dvjEDvQKTyG_CQ-TmrKAvA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:47:56 INFO - Downloaded 59652855 bytes. 11:47:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dvjEDvQKTyG_CQ-TmrKAvA/artifacts/public/build/target.tar.bz2 11:47:56 INFO - mkdir: /builds/slave/test/properties 11:47:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:47:56 INFO - Writing to file /builds/slave/test/properties/build_url 11:47:56 INFO - Contents: 11:47:56 INFO - build_url:https://queue.taskcluster.net/v1/task/dvjEDvQKTyG_CQ-TmrKAvA/artifacts/public/build/target.tar.bz2 11:47:56 INFO - Running post-action listener: _resource_record_post_action 11:47:56 INFO - Running post-action listener: set_extra_try_arguments 11:47:56 INFO - [mozharness: 2017-05-16 18:47:56.306838Z] Finished download-and-extract step (success) 11:47:56 INFO - [mozharness: 2017-05-16 18:47:56.307063Z] Running populate-webroot step. 11:47:56 INFO - Running pre-action listener: _resource_record_pre_action 11:47:56 INFO - Running main action method: populate_webroot 11:47:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:47:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:47:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:47:56 INFO - '--tppagecycles', 11:47:56 INFO - '7'], 11:47:56 INFO - 'tests': ['tsvgm']}}, 11:47:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:47:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:47:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:47:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:47:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:47:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:47:56 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:47:56 INFO - 'talos_options': ['--disable-e10s'], 11:47:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:47:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:47:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:47:56 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:47:56 INFO - 'talos_options': ['--disable-e10s'], 11:47:56 INFO - 'tests': ['damp', 'tps']}, 11:47:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:47:56 INFO - 'tests': ['damp', 'tps']}, 11:47:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:47:56 INFO - 'tests': ['dromaeo_dom']}, 11:47:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:47:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:47:56 INFO - 'tests': ['basic_compositor_video']}, 11:47:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:47:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:47:56 INFO - 'tests': ['a11yr', 11:47:56 INFO - 'ts_paint', 11:47:56 INFO - 'tpaint', 11:47:56 INFO - 'sessionrestore', 11:47:56 INFO - 'sessionrestore_no_auto_restore', 11:47:56 INFO - 'tabpaint']}, 11:47:56 INFO - 'other-e10s': {'tests': ['a11yr', 11:47:56 INFO - 'ts_paint', 11:47:56 INFO - 'tpaint', 11:47:56 INFO - 'sessionrestore', 11:47:56 INFO - 'sessionrestore_no_auto_restore', 11:47:56 INFO - 'tabpaint']}, 11:47:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:47:56 INFO - 'ts_paint', 11:47:56 INFO - 'tpaint', 11:47:56 INFO - 'sessionrestore', 11:47:56 INFO - 'sessionrestore_no_auto_restore', 11:47:56 INFO - 'tabpaint']}, 11:47:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:47:56 INFO - 'ts_paint', 11:47:56 INFO - 'tpaint', 11:47:56 INFO - 'sessionrestore', 11:47:56 INFO - 'sessionrestore_no_auto_restore', 11:47:56 INFO - 'tabpaint']}, 11:47:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:47:56 INFO - 'tests': ['a11yr', 11:47:56 INFO - 'ts_paint', 11:47:56 INFO - 'tpaint', 11:47:56 INFO - 'sessionrestore', 11:47:56 INFO - 'sessionrestore_no_auto_restore', 11:47:56 INFO - 'tabpaint']}, 11:47:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:47:56 INFO - 'tests': ['a11yr', 11:47:56 INFO - 'ts_paint', 11:47:56 INFO - 'tpaint', 11:47:56 INFO - 'sessionrestore', 11:47:56 INFO - 'sessionrestore_no_auto_restore', 11:47:56 INFO - 'tabpaint']}, 11:47:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:47:56 INFO - 'tests': ['tsvgx', 11:47:56 INFO - 'tsvgr_opacity', 11:47:56 INFO - 'tart', 11:47:56 INFO - 'tscrollx', 11:47:56 INFO - 'cart', 11:47:56 INFO - 'tsvg_static']}, 11:47:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:47:56 INFO - 'tsvgr_opacity', 11:47:56 INFO - 'tart', 11:47:56 INFO - 'tscrollx', 11:47:56 INFO - 'cart', 11:47:56 INFO - 'tsvg_static']}, 11:47:56 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:47:56 INFO - 'talos_options': ['--disable-e10s'], 11:47:56 INFO - 'tests': ['tp5o']}, 11:47:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:47:56 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:47:56 INFO - 'talos_options': ['--disable-e10s', 11:47:56 INFO - '--xperf_path', 11:47:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:47:56 INFO - 'tests': ['tp5n']}, 11:47:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:47:56 INFO - 'talos_options': ['--xperf_path', 11:47:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:47:56 INFO - 'tests': ['tp5n']}}, 11:47:56 INFO - 'talos.zip': {'path': '', 11:47:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:47:56 INFO - Running post-action listener: _resource_record_post_action 11:47:56 INFO - [mozharness: 2017-05-16 18:47:56.326552Z] Finished populate-webroot step (success) 11:47:56 INFO - [mozharness: 2017-05-16 18:47:56.326643Z] Running create-virtualenv step. 11:47:56 INFO - Running pre-action listener: _resource_record_pre_action 11:47:56 INFO - Running main action method: create_virtualenv 11:47:56 INFO - Creating virtualenv /builds/slave/test/build/venv 11:47:56 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 11:47:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:47:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:47:56 INFO - Using real prefix '/usr' 11:47:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:47:56 INFO - Installing distribute.............................................................................................................................................................................................done. 11:47:58 INFO - Installing pip.................done. 11:47:58 INFO - Return code: 0 11:47:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:47:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:47:59 INFO - Reading from file tmpfile_stdout 11:47:59 INFO - Output received: 11:47:59 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) 11:47:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:47:59 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')]} 11:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:59 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')]} 11:47:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:59 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 0xdb71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1055310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052400>, '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 0x10533b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053840>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1494959897.738146-2023400927', '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 11:47:59 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 11:47:59 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 11:47:59 INFO - Using env: {'DISPLAY': ':0', 11:47:59 INFO - 'HOME': '/home/cltbld', 11:47:59 INFO - 'LANG': 'en_US.UTF-8', 11:47:59 INFO - 'LANGUAGE': 'en_US:en', 11:47:59 INFO - 'LOGNAME': 'cltbld', 11:47:59 INFO - 'MAIL': '/var/mail/cltbld', 11:47:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:59 INFO - 'MOZ_NO_REMOTE': '1', 11:47:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:59 INFO - 'NO_EM_RESTART': '1', 11:47:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:59 INFO - 'PWD': '/builds/slave/test', 11:47:59 INFO - 'SHELL': '/bin/bash', 11:47:59 INFO - 'SHLVL': '1', 11:47:59 INFO - 'TERM': 'linux', 11:47:59 INFO - 'TMOUT': '86400', 11:47:59 INFO - 'USER': 'cltbld', 11:47:59 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1494959897.738146-2023400927', 11:47:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:59 INFO - '_': '/tools/buildbot/bin/python'} 11:47:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:59 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 11:47:59 INFO - Cleaning up... 11:47:59 INFO - Return code: 0 11:47:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:47:59 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')]} 11:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:59 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')]} 11:47:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:59 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 0xdb71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1055310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052400>, '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 0x10533b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053840>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1494959897.738146-2023400927', '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 11:47:59 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 11:47:59 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 11:47:59 INFO - Using env: {'DISPLAY': ':0', 11:47:59 INFO - 'HOME': '/home/cltbld', 11:47:59 INFO - 'LANG': 'en_US.UTF-8', 11:47:59 INFO - 'LANGUAGE': 'en_US:en', 11:47:59 INFO - 'LOGNAME': 'cltbld', 11:47:59 INFO - 'MAIL': '/var/mail/cltbld', 11:47:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:59 INFO - 'MOZ_NO_REMOTE': '1', 11:47:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:59 INFO - 'NO_EM_RESTART': '1', 11:47:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:59 INFO - 'PWD': '/builds/slave/test', 11:47:59 INFO - 'SHELL': '/bin/bash', 11:47:59 INFO - 'SHLVL': '1', 11:47:59 INFO - 'TERM': 'linux', 11:47:59 INFO - 'TMOUT': '86400', 11:47:59 INFO - 'USER': 'cltbld', 11:47:59 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1494959897.738146-2023400927', 11:47:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:59 INFO - '_': '/tools/buildbot/bin/python'} 11:47:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:59 INFO - Downloading/unpacking psutil>=3.1.1 11:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:48:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:48:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:48:00 INFO - Installing collected packages: psutil 11:48:00 INFO - Running setup.py install for psutil 11:48:00 INFO - building 'psutil._psutil_linux' extension 11:48:00 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 11:48:00 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 11:48:01 INFO - building 'psutil._psutil_posix' extension 11:48:01 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 11:48:01 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 11:48:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:48:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:48:01 INFO - Successfully installed psutil 11:48:01 INFO - Cleaning up... 11:48:01 INFO - Return code: 0 11:48:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:48:01 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')]} 11:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:01 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')]} 11:48:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:01 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 0xdb71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1055310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052400>, '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 0x10533b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053840>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1494959897.738146-2023400927', '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 11:48:01 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 11:48:01 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 11:48:01 INFO - Using env: {'DISPLAY': ':0', 11:48:01 INFO - 'HOME': '/home/cltbld', 11:48:01 INFO - 'LANG': 'en_US.UTF-8', 11:48:01 INFO - 'LANGUAGE': 'en_US:en', 11:48:01 INFO - 'LOGNAME': 'cltbld', 11:48:01 INFO - 'MAIL': '/var/mail/cltbld', 11:48:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:01 INFO - 'MOZ_NO_REMOTE': '1', 11:48:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:01 INFO - 'NO_EM_RESTART': '1', 11:48:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:01 INFO - 'PWD': '/builds/slave/test', 11:48:01 INFO - 'SHELL': '/bin/bash', 11:48:01 INFO - 'SHLVL': '1', 11:48:01 INFO - 'TERM': 'linux', 11:48:01 INFO - 'TMOUT': '86400', 11:48:01 INFO - 'USER': 'cltbld', 11:48:01 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1494959897.738146-2023400927', 11:48:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:01 INFO - '_': '/tools/buildbot/bin/python'} 11:48:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:48:01 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 11:48:01 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 11:48:01 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 11:48:01 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 11:48:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:48:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:48:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:48:02 INFO - Installing collected packages: mozsystemmonitor 11:48:02 INFO - Running setup.py install for mozsystemmonitor 11:48:02 INFO - Successfully installed mozsystemmonitor 11:48:02 INFO - Cleaning up... 11:48:02 INFO - Return code: 0 11:48:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:48:02 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')]} 11:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:02 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')]} 11:48:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:02 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 0xdb71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1055310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052400>, '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 0x10533b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053840>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1494959897.738146-2023400927', '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 11:48:02 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 11:48:02 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 11:48:02 INFO - Using env: {'DISPLAY': ':0', 11:48:02 INFO - 'HOME': '/home/cltbld', 11:48:02 INFO - 'LANG': 'en_US.UTF-8', 11:48:02 INFO - 'LANGUAGE': 'en_US:en', 11:48:02 INFO - 'LOGNAME': 'cltbld', 11:48:02 INFO - 'MAIL': '/var/mail/cltbld', 11:48:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:02 INFO - 'MOZ_NO_REMOTE': '1', 11:48:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:02 INFO - 'NO_EM_RESTART': '1', 11:48:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:02 INFO - 'PWD': '/builds/slave/test', 11:48:02 INFO - 'SHELL': '/bin/bash', 11:48:02 INFO - 'SHLVL': '1', 11:48:02 INFO - 'TERM': 'linux', 11:48:02 INFO - 'TMOUT': '86400', 11:48:02 INFO - 'USER': 'cltbld', 11:48:02 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1494959897.738146-2023400927', 11:48:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:02 INFO - '_': '/tools/buildbot/bin/python'} 11:48:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:03 INFO - Downloading/unpacking jsonschema==2.5.1 11:48:03 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 11:48:03 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 11:48:03 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 11:48:03 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 11:48:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:48:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:48:04 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 11:48:04 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 11:48:04 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 11:48:04 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 11:48:04 INFO - Downloading functools32-3.2.3-2.tar.gz 11:48:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:48:04 INFO - warning: no files found matching '*.txt' 11:48:04 INFO - no previously-included directories found matching 'build' 11:48:04 INFO - no previously-included directories found matching 'dist' 11:48:04 INFO - no previously-included directories found matching '.git*' 11:48:04 INFO - Installing collected packages: jsonschema, functools32 11:48:04 INFO - Running setup.py install for functools32 11:48:04 INFO - warning: no files found matching '*.txt' 11:48:04 INFO - no previously-included directories found matching 'build' 11:48:04 INFO - no previously-included directories found matching 'dist' 11:48:04 INFO - no previously-included directories found matching '.git*' 11:48:04 INFO - Successfully installed jsonschema functools32 11:48:04 INFO - Cleaning up... 11:48:04 INFO - Return code: 0 11:48:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:48:04 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')]} 11:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:04 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')]} 11:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:04 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 0xdb71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1055310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052400>, '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 0x10533b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053840>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1494959897.738146-2023400927', '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 11:48:04 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 11:48:04 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 11:48:04 INFO - Using env: {'DISPLAY': ':0', 11:48:04 INFO - 'HOME': '/home/cltbld', 11:48:04 INFO - 'LANG': 'en_US.UTF-8', 11:48:04 INFO - 'LANGUAGE': 'en_US:en', 11:48:04 INFO - 'LOGNAME': 'cltbld', 11:48:04 INFO - 'MAIL': '/var/mail/cltbld', 11:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:04 INFO - 'MOZ_NO_REMOTE': '1', 11:48:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:04 INFO - 'NO_EM_RESTART': '1', 11:48:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:04 INFO - 'PWD': '/builds/slave/test', 11:48:04 INFO - 'SHELL': '/bin/bash', 11:48:04 INFO - 'SHLVL': '1', 11:48:04 INFO - 'TERM': 'linux', 11:48:04 INFO - 'TMOUT': '86400', 11:48:04 INFO - 'USER': 'cltbld', 11:48:04 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1494959897.738146-2023400927', 11:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:04 INFO - '_': '/tools/buildbot/bin/python'} 11:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:48:04 INFO - Cleaning up... 11:48:04 INFO - Return code: 0 11:48:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:48:04 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')]} 11:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:04 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')]} 11:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:04 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 0xdb71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1055310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052400>, '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 0x10533b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053840>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1494959897.738146-2023400927', '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 11:48:04 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 11:48:04 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 11:48:04 INFO - Using env: {'DISPLAY': ':0', 11:48:04 INFO - 'HOME': '/home/cltbld', 11:48:04 INFO - 'LANG': 'en_US.UTF-8', 11:48:04 INFO - 'LANGUAGE': 'en_US:en', 11:48:04 INFO - 'LOGNAME': 'cltbld', 11:48:04 INFO - 'MAIL': '/var/mail/cltbld', 11:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:04 INFO - 'MOZ_NO_REMOTE': '1', 11:48:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:04 INFO - 'NO_EM_RESTART': '1', 11:48:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:04 INFO - 'PWD': '/builds/slave/test', 11:48:04 INFO - 'SHELL': '/bin/bash', 11:48:04 INFO - 'SHLVL': '1', 11:48:04 INFO - 'TERM': 'linux', 11:48:04 INFO - 'TMOUT': '86400', 11:48:04 INFO - 'USER': 'cltbld', 11:48:04 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1494959897.738146-2023400927', 11:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:04 INFO - '_': '/tools/buildbot/bin/python'} 11:48:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:05 INFO - Downloading/unpacking blobuploader==1.2.4 11:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:06 INFO - Downloading blobuploader-1.2.4.tar.gz 11:48:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:48:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:48:06 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 11:48:06 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 11:48:06 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 11:48:06 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 11:48:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:48:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:48:06 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 11:48:06 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 11:48:06 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 11:48:06 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 11:48:06 INFO - Downloading docopt-0.6.1.tar.gz 11:48:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:48:06 INFO - Installing collected packages: blobuploader, requests, docopt 11:48:06 INFO - Running setup.py install for blobuploader 11:48:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:48:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:48:06 INFO - Running setup.py install for requests 11:48:07 INFO - Running setup.py install for docopt 11:48:07 INFO - Successfully installed blobuploader requests docopt 11:48:07 INFO - Cleaning up... 11:48:07 INFO - Return code: 0 11:48:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:48:07 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')]} 11:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:07 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')]} 11:48:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:07 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 0xdb71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1055310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052400>, '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 0x10533b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053840>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1494959897.738146-2023400927', '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 11:48:07 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 11:48:07 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 11:48:07 INFO - Using env: {'DISPLAY': ':0', 11:48:07 INFO - 'HOME': '/home/cltbld', 11:48:07 INFO - 'LANG': 'en_US.UTF-8', 11:48:07 INFO - 'LANGUAGE': 'en_US:en', 11:48:07 INFO - 'LOGNAME': 'cltbld', 11:48:07 INFO - 'MAIL': '/var/mail/cltbld', 11:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:07 INFO - 'MOZ_NO_REMOTE': '1', 11:48:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:07 INFO - 'NO_EM_RESTART': '1', 11:48:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:07 INFO - 'PWD': '/builds/slave/test', 11:48:07 INFO - 'SHELL': '/bin/bash', 11:48:07 INFO - 'SHLVL': '1', 11:48:07 INFO - 'TERM': 'linux', 11:48:07 INFO - 'TMOUT': '86400', 11:48:07 INFO - 'USER': 'cltbld', 11:48:07 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1494959897.738146-2023400927', 11:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:07 INFO - '_': '/tools/buildbot/bin/python'} 11:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:48:07 INFO - Running setup.py (path:/tmp/pip-c701bt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:48:07 INFO - Running setup.py (path:/tmp/pip-PAGyTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:48:07 INFO - Running setup.py (path:/tmp/pip-Hj3wMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:48:07 INFO - Running setup.py (path:/tmp/pip-oaE0mZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:48:07 INFO - Running setup.py (path:/tmp/pip-hfT7iD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:48:07 INFO - Running setup.py (path:/tmp/pip-sMUEWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:48:08 INFO - Running setup.py (path:/tmp/pip-27EQFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:48:08 INFO - Running setup.py (path:/tmp/pip-z8cR7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:48:08 INFO - Running setup.py (path:/tmp/pip-mfmvd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:48:08 INFO - Running setup.py (path:/tmp/pip-bBj8px-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:48:08 INFO - Running setup.py (path:/tmp/pip-uZfGzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:48:08 INFO - Running setup.py (path:/tmp/pip-KoVchD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:48:08 INFO - Running setup.py (path:/tmp/pip-t_vTIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:48:08 INFO - Running setup.py (path:/tmp/pip-X9noHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:48:08 INFO - Running setup.py (path:/tmp/pip-xBwq9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:48:08 INFO - Running setup.py (path:/tmp/pip-E9fdXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:48:08 INFO - Running setup.py (path:/tmp/pip-7Y6fVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:48:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:48:08 INFO - Running setup.py install for manifestparser 11:48:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:48:08 INFO - Running setup.py install for mozcrash 11:48:08 INFO - Running setup.py install for mozdebug 11:48:09 INFO - Running setup.py install for mozdevice 11:48:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:48:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:48:09 INFO - Running setup.py install for mozfile 11:48:09 INFO - Running setup.py install for mozhttpd 11:48:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:48:09 INFO - Running setup.py install for mozinfo 11:48:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:48:09 INFO - Running setup.py install for mozInstall 11:48:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:48:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:48:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:48:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:48:09 INFO - Running setup.py install for mozleak 11:48:09 INFO - Running setup.py install for mozlog 11:48:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:48:09 INFO - Running setup.py install for moznetwork 11:48:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:48:09 INFO - Running setup.py install for mozprocess 11:48:10 INFO - Running setup.py install for mozprofile 11:48:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:48:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:48:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:48:10 INFO - Running setup.py install for mozrunner 11:48:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:48:10 INFO - Running setup.py install for mozscreenshot 11:48:10 INFO - Running setup.py install for moztest 11:48:10 INFO - Running setup.py install for mozversion 11:48:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:48:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:48:10 INFO - Cleaning up... 11:48:10 INFO - Return code: 0 11:48:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:48:10 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')]} 11:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:10 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')]} 11:48:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:10 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 0xdb71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1055310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052400>, '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 0x10533b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053840>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1494959897.738146-2023400927', '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 11:48:10 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 11:48:10 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 11:48:10 INFO - Using env: {'DISPLAY': ':0', 11:48:10 INFO - 'HOME': '/home/cltbld', 11:48:10 INFO - 'LANG': 'en_US.UTF-8', 11:48:10 INFO - 'LANGUAGE': 'en_US:en', 11:48:10 INFO - 'LOGNAME': 'cltbld', 11:48:10 INFO - 'MAIL': '/var/mail/cltbld', 11:48:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:10 INFO - 'MOZ_NO_REMOTE': '1', 11:48:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:10 INFO - 'NO_EM_RESTART': '1', 11:48:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:10 INFO - 'PWD': '/builds/slave/test', 11:48:10 INFO - 'SHELL': '/bin/bash', 11:48:10 INFO - 'SHLVL': '1', 11:48:10 INFO - 'TERM': 'linux', 11:48:10 INFO - 'TMOUT': '86400', 11:48:10 INFO - 'USER': 'cltbld', 11:48:10 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1494959897.738146-2023400927', 11:48:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:10 INFO - '_': '/tools/buildbot/bin/python'} 11:48:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:48:10 INFO - Running setup.py (path:/tmp/pip-ifnDFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:48:10 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)) 11:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:48:10 INFO - Running setup.py (path:/tmp/pip-VfPMeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:48:10 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)) 11:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:48:10 INFO - Running setup.py (path:/tmp/pip-jsQ0kC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:48:11 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)) 11:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:48:11 INFO - Running setup.py (path:/tmp/pip-AsxDMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:48:11 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)) 11:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:48:11 INFO - Running setup.py (path:/tmp/pip-RXciYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:48:11 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)) 11:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:48:11 INFO - Running setup.py (path:/tmp/pip-LOAMxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:48:11 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)) 11:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:48:11 INFO - Running setup.py (path:/tmp/pip-67xoK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:48:11 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)) 11:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:48:11 INFO - Running setup.py (path:/tmp/pip-yxSc49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:48:11 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)) 11:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:48:11 INFO - Running setup.py (path:/tmp/pip-cllkyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:48:11 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)) 11:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:48:11 INFO - Running setup.py (path:/tmp/pip-5wNwp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:48:11 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)) 11:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:48:11 INFO - Running setup.py (path:/tmp/pip-rlaCCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:48:11 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)) 11:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:48:11 INFO - Running setup.py (path:/tmp/pip-iiC16I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:48:11 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)) 11:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:48:11 INFO - Running setup.py (path:/tmp/pip-hWq0K8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:48:11 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)) 11:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:48:11 INFO - Running setup.py (path:/tmp/pip-2lQ24r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:48:11 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)) 11:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:48:11 INFO - Running setup.py (path:/tmp/pip-ZlPmqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:48:11 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)) 11:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:48:11 INFO - Running setup.py (path:/tmp/pip-V6RDXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:48:12 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)) 11:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:48:12 INFO - Running setup.py (path:/tmp/pip-LVkIOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:48:12 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)) 11:48:12 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)) 11:48:12 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)) 11:48:12 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)) 11:48:12 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)) 11:48:12 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)) 11:48:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:48:12 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 11:48:12 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 11:48:12 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 11:48:12 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 11:48:13 INFO - Downloading blessings-1.6.tar.gz 11:48:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:48:13 INFO - Installing collected packages: blessings 11:48:13 INFO - Running setup.py install for blessings 11:48:13 INFO - Successfully installed blessings 11:48:13 INFO - Cleaning up... 11:48:13 INFO - Return code: 0 11:48:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:48:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:48:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:48:13 INFO - Reading from file tmpfile_stdout 11:48:13 INFO - Current package versions: 11:48:13 INFO - argparse == 1.2.1 11:48:13 INFO - blessings == 1.6 11:48:13 INFO - blobuploader == 1.2.4 11:48:13 INFO - docopt == 0.6.1 11:48:13 INFO - functools32 == 3.2.3-2 11:48:13 INFO - jsonschema == 2.5.1 11:48:13 INFO - manifestparser == 1.1 11:48:13 INFO - mozInstall == 1.12 11:48:13 INFO - mozcrash == 1.0 11:48:13 INFO - mozdebug == 0.1 11:48:13 INFO - mozdevice == 0.49 11:48:13 INFO - mozfile == 1.2 11:48:13 INFO - mozhttpd == 0.7 11:48:13 INFO - mozinfo == 0.9 11:48:13 INFO - mozleak == 0.1 11:48:13 INFO - mozlog == 3.4 11:48:13 INFO - moznetwork == 0.27 11:48:13 INFO - mozprocess == 0.25 11:48:13 INFO - mozprofile == 0.28 11:48:13 INFO - mozrunner == 6.13 11:48:13 INFO - mozscreenshot == 0.1 11:48:13 INFO - mozsystemmonitor == 0.3 11:48:13 INFO - moztest == 0.8 11:48:13 INFO - mozversion == 1.4 11:48:13 INFO - psutil == 3.1.1 11:48:13 INFO - requests == 1.2.3 11:48:13 INFO - wsgiref == 0.1.2 11:48:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:13 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 0xdb71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1055310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052400>, '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 0x10533b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053840>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1494959897.738146-2023400927', '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 11:48:13 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 11:48:13 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 11:48:13 INFO - Using env: {'DISPLAY': ':0', 11:48:13 INFO - 'HOME': '/home/cltbld', 11:48:13 INFO - 'LANG': 'en_US.UTF-8', 11:48:13 INFO - 'LANGUAGE': 'en_US:en', 11:48:13 INFO - 'LOGNAME': 'cltbld', 11:48:13 INFO - 'MAIL': '/var/mail/cltbld', 11:48:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:13 INFO - 'MOZ_NO_REMOTE': '1', 11:48:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:13 INFO - 'NO_EM_RESTART': '1', 11:48:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:13 INFO - 'PWD': '/builds/slave/test', 11:48:13 INFO - 'SHELL': '/bin/bash', 11:48:13 INFO - 'SHLVL': '1', 11:48:13 INFO - 'TERM': 'linux', 11:48:13 INFO - 'TMOUT': '86400', 11:48:13 INFO - 'USER': 'cltbld', 11:48:13 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1494959897.738146-2023400927', 11:48:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:13 INFO - '_': '/tools/buildbot/bin/python'} 11:48:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:13 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)) 11:48:13 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)) 11:48:13 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)) 11:48:13 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)) 11:48:13 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)) 11:48:13 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)) 11:48:13 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)) 11:48:13 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)) 11:48:13 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)) 11:48:13 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)) 11:48:13 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)) 11:48:13 INFO - Cleaning up... 11:48:13 INFO - Return code: 0 11:48:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1055310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052400>, '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 0x10533b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053840>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1494959897.738146-2023400927', '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 11:48:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:48:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:48:13 INFO - Using env: {'DISPLAY': ':0', 11:48:13 INFO - 'HOME': '/home/cltbld', 11:48:13 INFO - 'LANG': 'en_US.UTF-8', 11:48:13 INFO - 'LANGUAGE': 'en_US:en', 11:48:13 INFO - 'LOGNAME': 'cltbld', 11:48:13 INFO - 'MAIL': '/var/mail/cltbld', 11:48:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:13 INFO - 'MOZ_NO_REMOTE': '1', 11:48:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:13 INFO - 'NO_EM_RESTART': '1', 11:48:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:13 INFO - 'PWD': '/builds/slave/test', 11:48:13 INFO - 'SHELL': '/bin/bash', 11:48:13 INFO - 'SHLVL': '1', 11:48:13 INFO - 'TERM': 'linux', 11:48:13 INFO - 'TMOUT': '86400', 11:48:13 INFO - 'USER': 'cltbld', 11:48:13 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1494959897.738146-2023400927', 11:48:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:13 INFO - '_': '/tools/buildbot/bin/python'} 11:48:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:48:14 INFO - Cleaning up... 11:48:14 INFO - Return code: 0 11:48:14 INFO - Running post-action listener: _resource_record_post_action 11:48:14 INFO - Running post-action listener: _start_resource_monitoring 11:48:14 INFO - Starting resource monitoring. 11:48:14 INFO - [mozharness: 2017-05-16 18:48:14.094593Z] Finished create-virtualenv step (success) 11:48:14 INFO - [mozharness: 2017-05-16 18:48:14.095113Z] Running install step. 11:48:14 INFO - Running pre-action listener: _resource_record_pre_action 11:48:14 INFO - Running main action method: install 11:48:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:48:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:48:14 INFO - Reading from file tmpfile_stdout 11:48:14 INFO - Detecting whether we're running mozinstall >=1.0... 11:48:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:48:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:48:14 INFO - Reading from file tmpfile_stdout 11:48:14 INFO - Output received: 11:48:14 INFO - Usage: mozinstall [options] installer 11:48:14 INFO - Options: 11:48:14 INFO - -h, --help show this help message and exit 11:48:14 INFO - -d DEST, --destination=DEST 11:48:14 INFO - Directory to install application into. [default: 11:48:14 INFO - "/builds/slave/test"] 11:48:14 INFO - --app=APP Application being installed. [default: firefox] 11:48:14 INFO - mkdir: /builds/slave/test/build/application 11:48:14 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'] 11:48:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:48:28 INFO - Reading from file tmpfile_stdout 11:48:28 INFO - Output received: 11:48:28 INFO - /builds/slave/test/build/application/firefox/firefox 11:48:28 INFO - Running post-action listener: _resource_record_post_action 11:48:28 INFO - [mozharness: 2017-05-16 18:48:28.450700Z] Finished install step (success) 11:48:28 INFO - [mozharness: 2017-05-16 18:48:28.450942Z] Running run-tests step. 11:48:28 INFO - Running pre-action listener: _resource_record_pre_action 11:48:28 INFO - Running main action method: run_tests 11:48:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:48:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:48:28 INFO - Python 2.7.3 11:48:28 INFO - Return code: 0 11:48:28 INFO - grabbing minidump binary from tooltool 11:48: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')]} 11:48:28 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 0x1052400>, '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 0x10533b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:48:28 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 11:48:28 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 11:48:28 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 11:48:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:48:28 INFO - Return code: 0 11:48:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:48:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:48:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:48:28 INFO - ENV: RUST_BACKTRACE is now 1 11:48:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:48:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:48:28 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/dvjEDvQKTyG_CQ-TmrKAvA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-087', '--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 11:48:28 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/dvjEDvQKTyG_CQ-TmrKAvA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-087 --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 11:48:28 INFO - Using env: {'DISPLAY': ':0', 11:48:28 INFO - 'HOME': '/home/cltbld', 11:48:28 INFO - 'LANG': 'en_US.UTF-8', 11:48:28 INFO - 'LANGUAGE': 'en_US:en', 11:48:28 INFO - 'LOGNAME': 'cltbld', 11:48:28 INFO - 'MAIL': '/var/mail/cltbld', 11:48:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:48:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:48:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:28 INFO - 'MOZ_NO_REMOTE': '1', 11:48:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:48:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:28 INFO - 'NO_EM_RESTART': '1', 11:48:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:28 INFO - 'PWD': '/builds/slave/test', 11:48:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:48:28 INFO - 'RUST_BACKTRACE': '1', 11:48:28 INFO - 'SHELL': '/bin/bash', 11:48:28 INFO - 'SHLVL': '1', 11:48:28 INFO - 'TERM': 'linux', 11:48:28 INFO - 'TMOUT': '86400', 11:48:28 INFO - 'USER': 'cltbld', 11:48:28 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1494959897.738146-2023400927', 11:48:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:28 INFO - '_': '/tools/buildbot/bin/python'} 11:48:28 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/dvjEDvQKTyG_CQ-TmrKAvA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-087', '--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 11:48:28 INFO - mozversion application_buildid: 20170516175032 11:48:28 INFO - mozversion application_changeset: 925160e8379600a79d869cf18df4f158e7eb1868 11:48:28 INFO - mozversion application_display_name: Firefox 11:48:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:48:28 INFO - mozversion application_name: Firefox 11:48:28 INFO - mozversion application_remotingname: firefox 11:48:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:48:28 INFO - mozversion application_vendor: Mozilla 11:48:28 INFO - mozversion application_version: 54.0 11:48:28 INFO - mozversion platform_buildid: 20170516175032 11:48:28 INFO - mozversion platform_changeset: 925160e8379600a79d869cf18df4f158e7eb1868 11:48:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:48:28 INFO - mozversion platform_version: 54.0 11:48:28 INFO - using testdate: 1494960508 11:48:28 INFO - actual date: 1494960508 11:48:28 INFO - starting webserver on 'localhost:51996' 11:48:28 INFO - SUITE-START | Running 2 tests 11:48:28 INFO - TEST-START | dromaeo_css 11:48:28 INFO - operating with platform_type : linux_ 11:48:28 INFO - Initialising browser for dromaeo_css test... 11:48:28 INFO - TEST-INFO | started process 3761 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgs3nPO/profile http://localhost:51996/getInfo.html) 11:48:32 INFO - PROCESS | 3761 | __metrics Screen width/height:1600/1200 11:48:32 INFO - PROCESS | 3761 | colorDepth:24 11:48:32 INFO - PROCESS | 3761 | Browser inner width/height: 1024/697 11:48:32 INFO - PROCESS | 3761 | __metrics 11:48:33 INFO - PROCESS | 3761 | 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" 11:48:33 INFO - PROCESS | 3761 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:48:34 INFO - PROCESS | 3761 | console.error: PushService: 11:48:34 INFO - PROCESS | 3761 | stateChangeProcessEnqueue: Error transitioning state 11:48:34 INFO - PROCESS | 3761 | UnknownError 11:48:34 INFO - TEST-INFO | 3761: exit 0 11:48:34 INFO - Browser initialized. 11:48:34 INFO - Running cycle 1/1 for dromaeo_css test... 11:48:34 INFO - TEST-INFO | started process 3852 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgs3nPO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:48:46 INFO - PROCESS | 3852 | RSS: Main: 141590528 11:48:46 INFO - PROCESS | 3852 | 11:51:48 INFO - PROCESS | 3852 | Cycle 1(1): loaded http://localhost:51996/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51996/tests/dromaeo/cssquery-ext.html) 11:51:50 INFO - PROCESS | 3852 | RSS: Main: 311525376 11:51:50 INFO - PROCESS | 3852 | 11:54:52 INFO - PROCESS | 3852 | Cycle 1(1): loaded http://localhost:51996/tests/dromaeo/cssquery-ext.html (next: http://localhost:51996/tests/dromaeo/cssquery-jquery.html) 11:54:52 INFO - PROCESS | 3852 | RSS: Main: 224718848 11:54:52 INFO - PROCESS | 3852 | 11:57:54 INFO - PROCESS | 3852 | Cycle 1(1): loaded http://localhost:51996/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51996/tests/dromaeo/cssquery-mootools.html) 11:57:55 INFO - PROCESS | 3852 | RSS: Main: 246214656 11:57:55 INFO - PROCESS | 3852 | 12:00:57 INFO - PROCESS | 3852 | Cycle 1(1): loaded http://localhost:51996/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51996/tests/dromaeo/cssquery-prototype.html) 12:00:57 INFO - PROCESS | 3852 | RSS: Main: 215986176 12:00:57 INFO - PROCESS | 3852 | 12:04:00 INFO - PROCESS | 3852 | Cycle 1(1): loaded http://localhost:51996/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51996/tests/dromaeo/cssquery-yui.html) 12:04:01 INFO - PROCESS | 3852 | RSS: Main: 174858240 12:04:01 INFO - PROCESS | 3852 | 12:07:03 INFO - PROCESS | 3852 | Cycle 1(1): loaded http://localhost:51996/tests/dromaeo/cssquery-yui.html (next: http://localhost:51996/tests/dromaeo/cssquery-dojo.html) 12:07:04 INFO - PROCESS | 3852 | RSS: Main: 272195584 12:07:04 INFO - PROCESS | 3852 | 12:07:04 INFO - PROCESS | 3852 | __start_tp_report 12:07:04 INFO - PROCESS | 3852 | _x_x_mozilla_page_load 12:07:04 INFO - PROCESS | 3852 | _x_x_mozilla_page_load_details 12:07:04 INFO - PROCESS | 3852 | |i|pagename|runs| 12:07:04 INFO - PROCESS | 3852 | |0;dojo.html;3420.7947523148614;3428.8799892003767;3440.7935523868555;3450.361683088629;3470.357983773002;5620.91568626471;5719.485246327829;5789.623674461157;5790.797322093733;5813.825585232439;5782.624129431584;5818.2145410369585;5842.415758424156;5859.32617748959;5882.823515294548;5264.921026184601;5274;5294.682319060868;5363.222332761748;5390.78436862525;5111.335526381566;5378.273933019032;5380.112281473552;5389.353277606673;5389.649672771257;5164.070467315882;5244.239585260135;5316.4683531646715;5326.840194794162;5337.306150200468;5382.3541175059045;5409.459054094598;5417.322834645669;5421.674699518042;5424.83725488234;5304.708241046741;5331.280277162611;5338.679679219259;5361.061814182542;5393.703346315951;5650.124230744241;5661.122526008476;5692.203091567184;5771.769129234825;5838.737256823453;6252.874942501125;6256.468200202989;6260.15487909131;6264.029075493306;6271.310155882895;6307.369263073701;6313.494920406402;6313.589616674947;6315.684215789192;6318.620882747004;5699.202111704323;5703.17303990919;5745.798897038667;5749.453801888856;5858.502027327682;6231.501479881598;6275.090111933744;6276.340984196685;6279.529035322369;6285;5995.310539287951;6000.939990600125;6014.849628759316;6021.548383871227;6028.788992385245;5965.13505541694;5996.2504686914135;6133.3866613338305;6140.815775526741;6146.508279337642;6111.561351782736;6128.1114238435175;6128.203333566607;6140.631562106288;6144.016957286813;5958.910616340759;5986.2217911671205;5991.191189189403;5996.430339117776;6177.320494745574;4644.047970166108;4658.767061646904;4667.136579732693;4667.509911459316;4673.205555055649;4239.427677263591;4252.064545799919;4252.234597772431;4295.269804133305;4296.2481565725875;5881.235439392852;5895.528357731371;6074.726637301332;6100.542459315569;6109.877802444015;6258.530610204253;6270.184875966095;6292.150559674477;6301.4328710416285;6321.1150438938585;6110.7861224856915;6112.419320164578;6129.509639228851;6131.601445906002;6133.202683651097;5175.689458632494;5209.843704688866;5290.894182116336;5293.920591191135;5307.124324486494;6452.290248072708;6501.869962600722;6513.4463570595135;6517.055027021151;6520.347965203442;6145.324014358506;6231.501479881508;6231.844203894758;6246.187995560548;6257.655828929453;6668.133142691419;6712.966435167793;6714.026466162477;6719.395254427125;6725.9663701681175;5931.6441013539325;6187.226596675416;6190.969045154746;6193.38066193377;6195.566310358412;6134.589663226307;6187.071939208975;6233.844153896189;6239.344868788893;6258.374162583706;6070.7875224366935;6175.84560385976;6186.938130618816;6193.163922870355;6201.10084037821;6177.660228687465;6180.6600636965395;6184.319724830175;6187.628742275478;6191.907121393093;5946.5540084494705;6008.369121242206;6024.668643224665;6036.547258955684;6125.173101631222;5916.437938395846;5919.970400147971;6181.196444462371;6205;6205.751769929152;5842.503387211965;5875.588708790344;5877;5878.970605146947;5944.286685597756 12:07:04 INFO - PROCESS | 3852 | |1;ext.html;756.4742503959747;838.1995194589166;860.6772460327377;908.4821651658553;931.017776246061;33551.66448335516;44331.55668443315;45451.318230226534;49453;49543.256851147264;45056.09887802242;45231.321530177076;45359.54640453595;45393.31910021352;45428.545714542845;7608.847823043536;7778.5721785301785;9257.074292570756;9387.389819661734;9413.62345506179;10801.729956751065;11068.446577671124;11357.318560886331;11373.715657108598;11376.715582110432;11079.335239885593;11122.944385278062;11126.054285385751;11126.721831954226;11127.554897804119;11092.667219983414;11095.500702468367;11097;11101.777964440747;11128.942750438695;10770.299930504492;10842.349459032404;10854.72863178419;10856.077233435088;10869.184811139196;42344.36483452751;42549.787251063855;42582.78708606468;42615;42630.78684606588;4243.236217480852;4285.892852678677;4293.592108749664;4373.825046998117;4431.49037860647;30333;31289.843550782327;31359.529607055912;32024.199395015312;32532.512012319836;4403.185410698999;4425.1149770045795;4520.094845278667;4520.186366454037;4529.6062819065455;242965;243176;244083;244827;244927.99999999822;54661.45338546643;54693.453065468835;54861.725691371284;54939.725301374034;54951.17573236405;57397.71301143467;57822.7108864453;57903.71048144732;57928.71035644795;57980.71009644925;16604.418845340355;16676.916615416845;16698;16700.248488818033;16700.58248543796;12729.363531823372;13008.154469959421;14713.632159195891;14715;14848.554543363716;14136.787948180785;14146.85853141476;14155.64610884736;14173.149611023371;14269.215193164475;5367.141257398797;5386.596005299618;5434.809781657623;5528.502434780889;5569.860753481195;991.3011327014582;998.256299057207;999.2605471950704;1010.888802231754;1030.0935177044153;27472;28393.722282497336;28520;28780.424391512053;28781;1311.9934400328127;1314.5530519623182;1326.8341457317836;1341.8255626768653;1342.6978929740926;13453.394597243148;13914.30428478572;14200.85799142016;14217.289135543182;14390.208538530273;326692;333582;333860;333888;334168;52407.73796130995;52644.473555264725;52697.999999999236;52753.47246527563;52780.20829687558;1434.619825746178;1494.7010597880467;1497.663025819182;1502.4966636177003;1506.7664512000658;27996.30009249785;28549.857250713612;29175.1247462568;29365.853170734008;29488.705112949454;37661.05847353728;37896.81051594725;37910.62089379181;37921;37967.62032379641;295756;297668;297852;297960;298658;24573;25015.12447064344;29198.56202157012;29933.102006939826;30035.249118772204;39311.41032884566;39490;39641.40537891876;40014.79992600018;40487.595124048385;31363.84318078395;31513;31695.36609267848;31696.683033170295;32163.839180803945;30990.69009309878;31138.532922005736;31230.21924451907;31395.372092557565;31963;35159.47260791141;35386;35590.8220458896;35906.28187436289;35951;29597.556036659036;29757;29883.25291867634;30154;30168.698313017467;23262.883685581462;23669.526609467368;23953.64069538993;24361.26916192517;24716.38209044788 12:07:04 INFO - PROCESS | 3852 | |2;jquery.html;460.2130357089377;465.74151346002975;472.8581425572327;477.55110196415364;479.4582122201911;20450.89774551127;21704.674429883526;21881.890590547064;22251.44371390716;22306.21928232512;23243.65134522979;23526.411839704015;23771.405714857137;23778.76221237787;23936.8803155984;5472.015037293286;6805.251422343551;7054.294570542956;7093.397061249774;7138.036365090698;6775.254721980578;6897.551659142165;6905.896411553831;7013.473989450812;7025.894611580805;6967.721291148373;6968.512204145712;6977.406920411746;6982.19704733957;6984.1619005719385;6875.48433867462;6938.340857618544;6958.756443524478;6969.16370035599;6972.686229119651;6733.49498787588;6801.353871382211;6815.352541508599;6818.761343353009;6848.931510684879;26690;26705.866470667523;26707.19878403651;26841;27003.72996270032;3094.210976201054;3242.5784647995847;3543.7165026797793;3738.6261373862667;3752.605976372496;16472.176391180394;16599.50201493957;16628.916855415766;17132.486025419257;17227.913860430745;2308.9307320780235;2418.9153379631803;2538.7588179122954;2576.304397812599;2587.870606469669;114881;118463;119067;119259.4037029818;119648;17894.373696920546;18167.63664726698;18463;18819;18990.52523686891;31681.36637267242;31832.681673183433;31867.681323186473;31874.20314492156;31904.68095319017;10739.248252622241;10916;10925.235233533576;10967.725806854733;11124.165687573464;9192.908070919206;9204.539773011322;9223.584938677775;9397.107274808883;9412.482313472825;9063.229625481908;9338.673146439842;9424.62301507932;9530.52347382628;9664.130228279348;3726.3851464508593;3895.9805200973815;3935.9212815743526;3989.813242784369;4009.5990400960254;1175.5767923547517;1187.5012494752225;1194.892459678633;1200.8498937632796;1214.5566868093258;20606.58786824255;20769.58460830775;20773.376798696063;20932;21030.263940762;1045.7019749371393;1123.4719681749564;1196.5154112584416;1224.7366816134574;1247.1457051919465;10773.676789696165;11304.943475282571;11326.603568875049;11338.943305283421;11375.20373573842;726777;737041;745228;756134;774403;79261.20738792654;80805;86765;96814.51592741991;109364;1253.8307328510716;1310.6592286005707;1329.7805862032656;1345.3407830163148;1352.776791829337;19614.705779413034;19818.50453738668;20072.59854802925;20087.59824803525;20197.798022019593;53056;53169;54010.45989540054;54230.728846355516;54350;70397.64801175961;70643.64678176782;70726.6463667699;71102.64448677724;73232.90150647638;12282.201656892274;12535.749285014066;12610.117291789487;12790.168639038433;12855.87144128584;13531.864681353061;13769.31153442344;13824;14022.368993395117;14393.064450810663;12503.187292825936;12526.937365313115;12562.811557826823;12567.308798016196;12725.363731813557;10560.524776384927;11409.087273018305;11749;11762.58830940913;12163.878361216275;6832.4776952599705;7484.962575187089;12425.62723118308;12825.551105711254;12876.291803950498;12174.513019479122;12235.143539952118;12338.321392323509;12370.42807734844;12638;11804.527818887149;12244.816327755269;12256.938715306724;12453.501859925502;12502.374881255719 12:07:04 INFO - PROCESS | 3852 | |3;mootools.html;1591.5861875912274;1598.9520314390566;1609.7665838453422;1612.7903372561566;1624.6019725167328;11153.776924461506;11987.940060299698;11995.2203106798;12017.098717596193;12031.75936481271;11221.270617409884;11626.186166968315;11665.183437159401;11666.941665291663;11672.47473863676;2472.258322503251;2508.147229941819;2508.2976766505317;2510.447701505675;2515.4591762771;2492.3519884829984;2530.278870521902;2543.631173479844;2573.5496288149593;2573.9742602574015;2370.1230544698487;2394.2577800881695;2489.2905521926255;2573.6654234949524;2577.3170109920884;2418.9274321770285;2464.7904928081134;2474.8762561871836;2500.3124140861228;2525.4065294655743;2457.619069044283;2474.3937735254976;2482.15606693725;2487.3905893056135;2489.2283392148493;11597.536098556047;11763.411829408495;11804.881951180465;11839.408029598486;11847.822282665767;6038.305594856603;6152.3847615238565;6172.321044685081;6178.752849885999;6195.504359651217;3705;3777.1501412182315;3790.033541446913;3864.516935383077;3915.0408150003145;1434.6700258940398;1450.4705782389458;1487.1820498725658;1515.1893736850732;1526.5496678479876;15513.146776927264;16056.759148612664;17247;17852.285908563772;17853.821461785345;4904.6566740327835;5084.694918304914;5169.224616307584;5181.818636347785;5197;13571;13572.117812342363;13574.389152488162;13576.93211533936;13586.660333491543;6197.597156184834;6203.47270482005;6210.782622608187;6212.689365531705;6216.595921265103;5449.6730196188355;5651.491365777099;5714.200011998323;5774;5785.247917770747;4093.207968190158;4127.926739047809;4159.292920203573;4171.0823618803815;4205.495340559152;1072.8068947589352;1073.8550295710136;1085.7122862441458;1103.4813637590319;1106.75651356703;1084.5173897615484;1087.4399684162663;1095.2771171027084;1098.983515247272;1116.079234631416;6717.875018583695;6889.173299204128;6900.930990690129;7372.705091796268;7427.8143046424275;1042.994785026085;1060.7189094889861;1061.6549621373085;1079.1312993040522;1093.7429704019548;4597.264437689953;4823.469418363977;4898.044881248123;4960.181570040975;4969.652124351333;13813.447462101605;14366.784498232535;14760.409583616534;14828.555143345717;14845;14444.638884027772;14583;14650.487232946796;14680;14680;10695.572177112985;10755.731106722238;10872.18458615607;11029.062529684907;11040.558377664964;6077.301110372364;7325.670344834602;7378.372838308589;7566.659500322388;7710.11333696632;13050.15174013686;13066.54267100647;13160.14459060158;13255.933720331337;13280.136791108547;13078.542251021168;13191.736165276448;13238.4042718076;13265.336733163496;13339.266340351374;10428.113610343205;10521.894781052091;10602;10620.575176992834;10628.52171652262;11352.148588855704;11374.601888933848;11503.194776365908;11569;11691.181617286707;9883.456409897524;9921.305508614329;9941;10050.69847904564;10167.898321016992;9517.428954262767;9549.665761698307;9590.856137158087;9619.855702164334;9889.85165222508;8893.822123557364;9041.728748137566;9057.320700947323;9068;9079.45523268606;6373.74505019794;6430;6448.419642232034;6457.515686323451;6499.5125365598715;6659.067730517828;6687.921702380108;6692.5649832762665;6742.662866856539;6867.038614594061 12:07:04 INFO - PROCESS | 3852 | |4;prototype.html;392.6917369864657;401.49211247771575;417.6011908627261;433.1337325349301;434.8521502689086;5179.715115668641;5221.765020574074;5233.450487698789;5238.580913526918;5242;4942.159832828419;5064.594832413407;5065.873353166173;5110.8466745997675;5170.896582068356;4508.842190523333;4517.576963256572;4518.887027824314;4532.773361331937;4543.227651299287;4536.931946020813;4542.136993971135;4550.613197878184;4571.3600095986585;4574.359589657451;4340.370646256291;4509.301058335963;4534.251848445003;4545.477270113946;4559.703619264754;4492.39352687388;4521.276595744698;4525.660575456854;4536.296873984521;4537.455505339381;4353.564643535653;4369.366441865944;4375.628071613916;4380.102079073782;4403.801828917674;5030.459617892977;5089.491050894918;5128.897422051538;5145.6398052136365;5207.09940871583;5189.714565698885;5215.739213039333;5228.816991405321;5250.5274525292525;5268.050821196143;5433.864153396157;5477.260569823103;5479.315085614298;5495.670259784426;5500.862478438071;4631.374764406829;4778.331033655291;4813.566778989873;4816.325714399987;4851.393575803025;5441.238226648273;5534.1975413565215;5585.301837270341;5626.9437305626825;5676.631018983753;4938.851834444972;4943.332650092191;4971.353724015855;4976.570851941775;4992.151334273182;4865.70805751656;4904.792843220565;4966.304717339575;5079.958608485252;5141.529467609349;5121.667091639031;5155.561777248976;5175.4824517548695;5191.273221748958;5195.272661827347;5318.601104917069;5446.373667028342;5454.481824226692;5475.425080366584;5485.314335708036;1675.9497215083568;1720.5698575356162;1724.1982478147722;1749.7375393691048;1770.8406243438153;1429.5490077571067;1435.526276328809;1442.235615123986;1460.2406748490725;1484.3320505772447;5403.567714582824;5427.348718153768;5496.615236933456;5515.476029777245;5550.583706221969;5280.254267780732;5557.333120025542;5572.523281330451;5584.664920104726;5685.744141513642;5440.93244567062;5442.755076021588;5445.665811876116;5451.863703407367;5507.394186639466;2822.407294468144;2844.672862620825;2904.4191161767308;2947.1747910585073;2954.926126846803;5704.80033198836;5784.971075144597;5797.449242321973;5838.824835254949;5865.970670146622;5581.748821303051;5665.858353541194;5668;5686.886262274731;5726.627769194989;5569.554435645138;5792.21805056312;5857.912131318119;5875.588708790429;5878.500982249585;5455.399906010415;5468;5528.308961379827;5529.640573362719;5541.3904470509015;5239.030779305841;5377.891003546568;5416.458354164552;5462.8361149165585;5497.670139791625;5845.240118784531;5896;5900.262467191601;5915.733791979457;5917.940820591739;4485.237509623437;4685.67200295976;4977.129002424489;4994.275830004702;5000.374953130859;5555.638883472561;5568.132411807841;5585.916211256753;5593.916091258716;5598;5444.482774136451;5449.073657478318;5477.808276710296;5502.697351645698;5514.5864060194845;5223.425423203521;5435.646682965595;5446.264754258283;5446.455354464521;5462.235287059894;5411.186183184801;5428.59285553593;5428.828468612586;5443.292371991616;5458.563314934875;5380.483349864003;5470.261514695465;5494.615376923577;5536.640118392292;5609;5248.868778280574;5261.158214685632;5320.787168513371;5342.198670199501;5343.599230057684 12:07:04 INFO - PROCESS | 3852 | |5;yui.html;852.0542198160045;887.2680038967853;922.8154369126174;926.5459924636925;935.854942483915;17439.65120697587;18517.2593096276;18975.71536426955;19220.711689324635;19323.227070917164;16569;16700.08149551774;16832.158392080408;17560.121993900317;17701.55746106348;885.8405487012335;913.8446464101119;931.8695382646434;942.420411446962;946.191006689281;914.7530166854946;917.1516347378681;917.3074328881685;917.6421195733669;917.8439665256923;977.0766625538869;979.3095867413457;980.0738302304326;980.1717548671361;980.5097451274363;968.8934217236099;974.0357046523891;975.7853272280087;975.8194733974202;977.3598293117948;717.4834119433999;718.2171433137905;719.7732714195012;720.4452571519953;720.4920531025614;18661.440156795317;18704.345347912757;19030.238790448366;19719.80280197194;19934.401967940987;16614.83385166145;16815.579610509714;16950.745738813926;17062.402815901507;17679.116044197737;13311.534096306583;13842.930785346109;14261.286935653176;14334.856651433456;14377;4975.7263350515705;5005.799768009275;5118.539331460186;5169.508896654812;5296.3379577552805;80960.59519702423;81288.59355703184;83124;83166;84000.57999709963;12624.684382890502;12770.680732981564;12793.168444051107;12970.870291296966;13039.478420863059;22772.836580524825;23168.304950851503;23238.419039523807;23246.070157193863;23405.648915266283;8987.685431009882;9106.18044375996;9107.08929107084;9136.81726365469;9173.724788256362;5120.615953803405;5183.248428977777;5209.29674493946;5237.895242095136;5369.328833895763;3690;3784.3377408953875;3791.3175628387157;3801.2967600993907;3820.3887378019385;618.4186864347499;631.311870061635;637.7704026550438;640.6924676155378;643.3277225299573;687.7730348984823;702.8734827730955;724.8577416897703;725.8911163325544;734.8793090536974;11184.655138143542;11195.496202670736;11302.321860688386;11589.188756787113;11726.824097638542;628.2868943748787;629.6725702634604;640.385230179024;642.6915080761261;661.3188415931598;5254.842354729364;5452.093373792596;5563.66618002913;5580.609357344947;5583.497485226349;85452.14547854566;85761.57119214365;85993.57003214944;86838.56580717055;89059;71381;71603.6419817908;71689.2831071693;71992.64003679948;72944;65881;66035.66982165155;66088;68775.65612171908;68965.31034689689;10604.628837990942;10742.570297188338;11023.503942322453;11051.889481105087;11063.72340691489;46435.53564464312;46923.296150557086;47043.29435058546;47854.760726196146;47930.281045785036;51321.486785133166;51462;55306.72346638402;57303.71348143233;57579.712101439225;13858;14046.929765351108;14120.152790832582;14755.926220368829;14927.253637318308;16219.594510137342;16229.350825966829;16512.83487165113;17186.484405467854;17201.913990429966;16239.269232884311;16675.49973500797;17159;17407.129643518027;17428.128593570524;14889.255537222878;15376.46182383656;15393.538193854203;15482.612934676723;15627.76558351603;15719.21403929776;15821.367145314058;15863.20683965774;15956;15994.680106397574;11420.428978551205;11425.485853136795;11842;12057.638270851889;12164.75670486603;13068.477260909458;13262.20426774358;13349;13362.265075420944;13427.26150061756 12:07:04 INFO - PROCESS | 3852 | __end_tp_report 12:07:04 INFO - PROCESS | 3852 | __start_cc_report 12:07:04 INFO - PROCESS | 3852 | _x_x_mozilla_cycle_collect,1743 12:07:04 INFO - PROCESS | 3852 | __end_cc_report 12:07:04 INFO - PROCESS | 3852 | __startTimestamp1494961624077__endTimestamp 12:07:04 INFO - PROCESS | 3852 | 12:07:04 INFO - PROCESS | 3852 | ------- Summary: start ------- 12:07:04 INFO - PROCESS | 3852 | Number of tests: 6 12:07:04 INFO - PROCESS | 3852 | 12:07:04 INFO - PROCESS | 3852 | [#0] dojo.html Cycles:165 Average:5788.08 Median:5996.43 stddev:659.40 (11.0%) stddev-sans-first:634.73 12:07:04 INFO - PROCESS | 3852 | Values: 3420.8 3428.9 3440.8 3450.4 3470.4 5620.9 5719.5 5789.6 5790.8 5813.8 5782.6 5818.2 5842.4 5859.3 5882.8 5264.9 5274.0 5294.7 5363.2 5390.8 5111.3 5378.3 5380.1 5389.4 5389.6 5164.1 5244.2 5316.5 5326.8 5337.3 5382.4 5409.5 5417.3 5421.7 5424.8 5304.7 5331.3 5338.7 5361.1 5393.7 5650.1 5661.1 5692.2 5771.8 5838.7 6252.9 6256.5 6260.2 6264.0 6271.3 6307.4 6313.5 6313.6 6315.7 6318.6 5699.2 5703.2 5745.8 5749.5 5858.5 6231.5 6275.1 6276.3 6279.5 6285.0 5995.3 6000.9 6014.8 6021.5 6028.8 5965.1 5996.3 6133.4 6140.8 6146.5 6111.6 6128.1 6128.2 6140.6 6144.0 5958.9 5986.2 5991.2 5996.4 6177.3 4644.0 4658.8 4667.1 4667.5 4673.2 4239.4 4252.1 4252.2 4295.3 4296.2 5881.2 5895.5 6074.7 6100.5 6109.9 6258.5 6270.2 6292.2 6301.4 6321.1 6110.8 6112.4 6129.5 6131.6 6133.2 5175.7 5209.8 5290.9 5293.9 5307.1 6452.3 6501.9 6513.4 6517.1 6520.3 6145.3 6231.5 6231.8 6246.2 6257.7 6668.1 6713.0 6714.0 6719.4 6726.0 5931.6 6187.2 6191.0 6193.4 6195.6 6134.6 6187.1 6233.8 6239.3 6258.4 6070.8 6175.8 6186.9 6193.2 6201.1 6177.7 6180.7 6184.3 6187.6 6191.9 5946.6 6008.4 6024.7 6036.5 6125.2 5916.4 5920.0 6181.2 6205.0 6205.8 5842.5 5875.6 5877.0 5879.0 5944.3 12:07:04 INFO - PROCESS | 3852 | 12:07:04 INFO - PROCESS | 3852 | [#1] ext.html Cycles:180 Average:45809.32 Median:31260.03 stddev:76721.69 (245.4%) stddev-sans-first:76862.34 12:07:04 INFO - PROCESS | 3852 | Values: 756.5 838.2 860.7 908.5 931.0 33551.7 44331.6 45451.3 49453.0 49543.3 45056.1 45231.3 45359.5 45393.3 45428.5 7608.8 7778.6 9257.1 9387.4 9413.6 10801.7 11068.4 11357.3 11373.7 11376.7 11079.3 11122.9 11126.1 11126.7 11127.6 11092.7 11095.5 11097.0 11101.8 11128.9 10770.3 10842.3 10854.7 10856.1 10869.2 42344.4 42549.8 42582.8 42615.0 42630.8 4243.2 4285.9 4293.6 4373.8 4431.5 30333.0 31289.8 31359.5 32024.2 32532.5 4403.2 4425.1 4520.1 4520.2 4529.6 242965.0 243176.0 244083.0 244827.0 244928.0 54661.5 54693.5 54861.7 54939.7 54951.2 57397.7 57822.7 57903.7 57928.7 57980.7 16604.4 16676.9 16698.0 16700.2 16700.6 12729.4 13008.2 14713.6 14715.0 14848.6 14136.8 14146.9 14155.6 14173.1 14269.2 5367.1 5386.6 5434.8 5528.5 5569.9 991.3 998.3 999.3 1010.9 1030.1 27472.0 28393.7 28520.0 28780.4 28781.0 1312.0 1314.6 1326.8 1341.8 1342.7 13453.4 13914.3 14200.9 14217.3 14390.2 326692.0 333582.0 333860.0 333888.0 334168.0 52407.7 52644.5 52698.0 52753.5 52780.2 1434.6 1494.7 1497.7 1502.5 1506.8 27996.3 28549.9 29175.1 29365.9 29488.7 37661.1 37896.8 37910.6 37921.0 37967.6 295756.0 297668.0 297852.0 297960.0 298658.0 24573.0 25015.1 29198.6 29933.1 30035.2 39311.4 39490.0 39641.4 40014.8 40487.6 31363.8 31513.0 31695.4 31696.7 32163.8 30990.7 31138.5 31230.2 31395.4 31963.0 35159.5 35386.0 35590.8 35906.3 35951.0 29597.6 29757.0 29883.3 30154.0 30168.7 23262.9 23669.5 23953.6 24361.3 24716.4 12:07:04 INFO - PROCESS | 3852 | 12:07:04 INFO - PROCESS | 3852 | [#2] jquery.html Cycles:180 Average:39910.31 Median:23385.03 stddev:122653.61 (524.5%) stddev-sans-first:122961.92 12:07:04 INFO - PROCESS | 3852 | Values: 460.2 465.7 472.9 477.6 479.5 20450.9 21704.7 21881.9 22251.4 22306.2 23243.7 23526.4 23771.4 23778.8 23936.9 5472.0 6805.3 7054.3 7093.4 7138.0 6775.3 6897.6 6905.9 7013.5 7025.9 6967.7 6968.5 6977.4 6982.2 6984.2 6875.5 6938.3 6958.8 6969.2 6972.7 6733.5 6801.4 6815.4 6818.8 6848.9 26690.0 26705.9 26707.2 26841.0 27003.7 3094.2 3242.6 3543.7 3738.6 3752.6 16472.2 16599.5 16628.9 17132.5 17227.9 2308.9 2418.9 2538.8 2576.3 2587.9 114881.0 118463.0 119067.0 119259.4 119648.0 17894.4 18167.6 18463.0 18819.0 18990.5 31681.4 31832.7 31867.7 31874.2 31904.7 10739.2 10916.0 10925.2 10967.7 11124.2 9192.9 9204.5 9223.6 9397.1 9412.5 9063.2 9338.7 9424.6 9530.5 9664.1 3726.4 3896.0 3935.9 3989.8 4009.6 1175.6 1187.5 1194.9 1200.8 1214.6 20606.6 20769.6 20773.4 20932.0 21030.3 1045.7 1123.5 1196.5 1224.7 1247.1 10773.7 11304.9 11326.6 11338.9 11375.2 726777.0 737041.0 745228.0 756134.0 774403.0 79261.2 80805.0 86765.0 96814.5 109364.0 1253.8 1310.7 1329.8 1345.3 1352.8 19614.7 19818.5 20072.6 20087.6 20197.8 53056.0 53169.0 54010.5 54230.7 54350.0 70397.6 70643.6 70726.6 71102.6 73232.9 12282.2 12535.7 12610.1 12790.2 12855.9 13531.9 13769.3 13824.0 14022.4 14393.1 12503.2 12526.9 12562.8 12567.3 12725.4 10560.5 11409.1 11749.0 11762.6 12163.9 6832.5 7485.0 12425.6 12825.6 12876.3 12174.5 12235.1 12338.3 12370.4 12638.0 11804.5 12244.8 12256.9 12453.5 12502.4 12:07:04 INFO - PROCESS | 3852 | 12:07:04 INFO - PROCESS | 3852 | [#3] mootools.html Cycles:180 Average:7360.70 Median:2461.20 stddev:4609.37 (187.3%) stddev-sans-first:4601.92 12:07:04 INFO - PROCESS | 3852 | Values: 1591.6 1599.0 1609.8 1612.8 1624.6 11153.8 11987.9 11995.2 12017.1 12031.8 11221.3 11626.2 11665.2 11666.9 11672.5 2472.3 2508.1 2508.3 2510.4 2515.5 2492.4 2530.3 2543.6 2573.5 2574.0 2370.1 2394.3 2489.3 2573.7 2577.3 2418.9 2464.8 2474.9 2500.3 2525.4 2457.6 2474.4 2482.2 2487.4 2489.2 11597.5 11763.4 11804.9 11839.4 11847.8 6038.3 6152.4 6172.3 6178.8 6195.5 3705.0 3777.2 3790.0 3864.5 3915.0 1434.7 1450.5 1487.2 1515.2 1526.5 15513.1 16056.8 17247.0 17852.3 17853.8 4904.7 5084.7 5169.2 5181.8 5197.0 13571.0 13572.1 13574.4 13576.9 13586.7 6197.6 6203.5 6210.8 6212.7 6216.6 5449.7 5651.5 5714.2 5774.0 5785.2 4093.2 4127.9 4159.3 4171.1 4205.5 1072.8 1073.9 1085.7 1103.5 1106.8 1084.5 1087.4 1095.3 1099.0 1116.1 6717.9 6889.2 6900.9 7372.7 7427.8 1043.0 1060.7 1061.7 1079.1 1093.7 4597.3 4823.5 4898.0 4960.2 4969.7 13813.4 14366.8 14760.4 14828.6 14845.0 14444.6 14583.0 14650.5 14680.0 14680.0 10695.6 10755.7 10872.2 11029.1 11040.6 6077.3 7325.7 7378.4 7566.7 7710.1 13050.2 13066.5 13160.1 13255.9 13280.1 13078.5 13191.7 13238.4 13265.3 13339.3 10428.1 10521.9 10602.0 10620.6 10628.5 11352.1 11374.6 11503.2 11569.0 11691.2 9883.5 9921.3 9941.0 10050.7 10167.9 9517.4 9549.7 9590.9 9619.9 9889.9 8893.8 9041.7 9057.3 9068.0 9079.5 6373.7 6430.0 6448.4 6457.5 6499.5 6659.1 6687.9 6692.6 6742.7 6867.0 12:07:04 INFO - PROCESS | 3852 | 12:07:04 INFO - PROCESS | 3852 | [#4] prototype.html Cycles:180 Average:4834.83 Median:5249.70 stddev:1240.70 (23.6%) stddev-sans-first:1198.55 12:07:04 INFO - PROCESS | 3852 | Values: 392.7 401.5 417.6 433.1 434.9 5179.7 5221.8 5233.5 5238.6 5242.0 4942.2 5064.6 5065.9 5110.8 5170.9 4508.8 4517.6 4518.9 4532.8 4543.2 4536.9 4542.1 4550.6 4571.4 4574.4 4340.4 4509.3 4534.3 4545.5 4559.7 4492.4 4521.3 4525.7 4536.3 4537.5 4353.6 4369.4 4375.6 4380.1 4403.8 5030.5 5089.5 5128.9 5145.6 5207.1 5189.7 5215.7 5228.8 5250.5 5268.1 5433.9 5477.3 5479.3 5495.7 5500.9 4631.4 4778.3 4813.6 4816.3 4851.4 5441.2 5534.2 5585.3 5626.9 5676.6 4938.9 4943.3 4971.4 4976.6 4992.2 4865.7 4904.8 4966.3 5080.0 5141.5 5121.7 5155.6 5175.5 5191.3 5195.3 5318.6 5446.4 5454.5 5475.4 5485.3 1675.9 1720.6 1724.2 1749.7 1770.8 1429.5 1435.5 1442.2 1460.2 1484.3 5403.6 5427.3 5496.6 5515.5 5550.6 5280.3 5557.3 5572.5 5584.7 5685.7 5440.9 5442.8 5445.7 5451.9 5507.4 2822.4 2844.7 2904.4 2947.2 2954.9 5704.8 5785.0 5797.4 5838.8 5866.0 5581.7 5665.9 5668.0 5686.9 5726.6 5569.6 5792.2 5857.9 5875.6 5878.5 5455.4 5468.0 5528.3 5529.6 5541.4 5239.0 5377.9 5416.5 5462.8 5497.7 5845.2 5896.0 5900.3 5915.7 5917.9 4485.2 4685.7 4977.1 4994.3 5000.4 5555.6 5568.1 5585.9 5593.9 5598.0 5444.5 5449.1 5477.8 5502.7 5514.6 5223.4 5435.6 5446.3 5446.5 5462.2 5411.2 5428.6 5428.8 5443.3 5458.6 5380.5 5470.3 5494.6 5536.6 5609.0 5248.9 5261.2 5320.8 5342.2 5343.6 12:07:04 INFO - PROCESS | 3852 | 12:07:04 INFO - PROCESS | 3852 | [#5] yui.html Cycles:180 Average:19299.18 Median:4990.76 stddev:23647.92 (473.8%) stddev-sans-first:23673.69 12:07:04 INFO - PROCESS | 3852 | Values: 852.1 887.3 922.8 926.5 935.9 17439.7 18517.3 18975.7 19220.7 19323.2 16569.0 16700.1 16832.2 17560.1 17701.6 885.8 913.8 931.9 942.4 946.2 914.8 917.2 917.3 917.6 917.8 977.1 979.3 980.1 980.2 980.5 968.9 974.0 975.8 975.8 977.4 717.5 718.2 719.8 720.4 720.5 18661.4 18704.3 19030.2 19719.8 19934.4 16614.8 16815.6 16950.7 17062.4 17679.1 13311.5 13842.9 14261.3 14334.9 14377.0 4975.7 5005.8 5118.5 5169.5 5296.3 80960.6 81288.6 83124.0 83166.0 84000.6 12624.7 12770.7 12793.2 12970.9 13039.5 22772.8 23168.3 23238.4 23246.1 23405.6 8987.7 9106.2 9107.1 9136.8 9173.7 5120.6 5183.2 5209.3 5237.9 5369.3 3690.0 3784.3 3791.3 3801.3 3820.4 618.4 631.3 637.8 640.7 643.3 687.8 702.9 724.9 725.9 734.9 11184.7 11195.5 11302.3 11589.2 11726.8 628.3 629.7 640.4 642.7 661.3 5254.8 5452.1 5563.7 5580.6 5583.5 85452.1 85761.6 85993.6 86838.6 89059.0 71381.0 71603.6 71689.3 71992.6 72944.0 65881.0 66035.7 66088.0 68775.7 68965.3 10604.6 10742.6 11023.5 11051.9 11063.7 46435.5 46923.3 47043.3 47854.8 47930.3 51321.5 51462.0 55306.7 57303.7 57579.7 13858.0 14046.9 14120.2 14755.9 14927.3 16219.6 16229.4 16512.8 17186.5 17201.9 16239.3 16675.5 17159.0 17407.1 17428.1 14889.3 15376.5 15393.5 15482.6 15627.8 15719.2 15821.4 15863.2 15956.0 15994.7 11420.4 11425.5 11842.0 12057.6 12164.8 13068.5 13262.2 13349.0 13362.3 13427.3 12:07:04 INFO - PROCESS | 3852 | -------- Summary: end -------- 12:07:04 INFO - PROCESS | 3852 | 12:07:04 INFO - TEST-INFO | 3852: exit 0 12:07:04 INFO - TEST-OK | dromaeo_css | took 1116104ms 12:07:04 INFO - TEST-START | kraken 12:07:04 INFO - operating with platform_type : linux_ 12:07:04 INFO - Initialising browser for kraken test... 12:07:04 INFO - TEST-INFO | started process 4160 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0b2Kes/profile http://localhost:51996/getInfo.html) 12:07:08 INFO - PROCESS | 4160 | __metrics Screen width/height:1600/1200 12:07:08 INFO - PROCESS | 4160 | colorDepth:24 12:07:08 INFO - PROCESS | 4160 | Browser inner width/height: 1024/697 12:07:08 INFO - PROCESS | 4160 | __metrics 12:07:09 INFO - PROCESS | 4160 | 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" 12:07:09 INFO - PROCESS | 4160 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:07:10 INFO - PROCESS | 4160 | console.error: PushService: 12:07:10 INFO - PROCESS | 4160 | stateChangeProcessEnqueue: Error transitioning state 12:07:10 INFO - PROCESS | 4160 | UnknownError 12:07:10 INFO - TEST-INFO | 4160: exit 0 12:07:10 INFO - Browser initialized. 12:07:10 INFO - Running cycle 1/1 for kraken test... 12:07:10 INFO - TEST-INFO | started process 4253 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0b2Kes/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:07:22 INFO - PROCESS | 4253 | RSS: Main: 141754368 12:07:22 INFO - PROCESS | 4253 | 12:07:24 INFO - PROCESS | 4253 | Cycle 1(1): loaded http://localhost:51996/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51996/tests/kraken/driver.html?testName=audio-beat-detection) 12:07:25 INFO - PROCESS | 4253 | RSS: Main: 183959552 12:07:25 INFO - PROCESS | 4253 | 12:07:28 INFO - PROCESS | 4253 | Cycle 1(1): loaded http://localhost:51996/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51996/tests/kraken/driver.html?testName=audio-dft) 12:07:28 INFO - PROCESS | 4253 | RSS: Main: 173780992 12:07:28 INFO - PROCESS | 4253 | 12:07:31 INFO - PROCESS | 4253 | Cycle 1(1): loaded http://localhost:51996/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51996/tests/kraken/driver.html?testName=audio-fft) 12:07:32 INFO - PROCESS | 4253 | RSS: Main: 265150464 12:07:32 INFO - PROCESS | 4253 | 12:07:34 INFO - PROCESS | 4253 | Cycle 1(1): loaded http://localhost:51996/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51996/tests/kraken/driver.html?testName=audio-oscillator) 12:07:34 INFO - PROCESS | 4253 | RSS: Main: 171425792 12:07:34 INFO - PROCESS | 4253 | 12:07:36 INFO - PROCESS | 4253 | Cycle 1(1): loaded http://localhost:51996/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51996/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:07:37 INFO - PROCESS | 4253 | RSS: Main: 173932544 12:07:37 INFO - PROCESS | 4253 | 12:07:40 INFO - PROCESS | 4253 | Cycle 1(1): loaded http://localhost:51996/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51996/tests/kraken/driver.html?testName=imaging-darkroom) 12:07:41 INFO - PROCESS | 4253 | RSS: Main: 210706432 12:07:41 INFO - PROCESS | 4253 | 12:07:44 INFO - PROCESS | 4253 | Cycle 1(1): loaded http://localhost:51996/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51996/tests/kraken/driver.html?testName=imaging-desaturate) 12:07:45 INFO - PROCESS | 4253 | RSS: Main: 213491712 12:07:45 INFO - PROCESS | 4253 | 12:07:47 INFO - PROCESS | 4253 | Cycle 1(1): loaded http://localhost:51996/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51996/tests/kraken/driver.html?testName=json-parse-financial) 12:07:48 INFO - PROCESS | 4253 | RSS: Main: 211124224 12:07:48 INFO - PROCESS | 4253 | 12:07:49 INFO - PROCESS | 4253 | Cycle 1(1): loaded http://localhost:51996/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51996/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:07:50 INFO - PROCESS | 4253 | RSS: Main: 173617152 12:07:50 INFO - PROCESS | 4253 | 12:07:52 INFO - PROCESS | 4253 | Cycle 1(1): loaded http://localhost:51996/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51996/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:07:52 INFO - PROCESS | 4253 | RSS: Main: 180027392 12:07:52 INFO - PROCESS | 4253 | 12:07:54 INFO - PROCESS | 4253 | Cycle 1(1): loaded http://localhost:51996/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51996/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:07:55 INFO - PROCESS | 4253 | RSS: Main: 190541824 12:07:55 INFO - PROCESS | 4253 | 12:07:58 INFO - PROCESS | 4253 | Cycle 1(1): loaded http://localhost:51996/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51996/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:07:58 INFO - PROCESS | 4253 | RSS: Main: 199634944 12:07:58 INFO - PROCESS | 4253 | 12:08:01 INFO - PROCESS | 4253 | Cycle 1(1): loaded http://localhost:51996/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51996/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:08:02 INFO - PROCESS | 4253 | RSS: Main: 195547136 12:08:02 INFO - PROCESS | 4253 | 12:08:03 INFO - PROCESS | 4253 | Cycle 1(1): loaded http://localhost:51996/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51996/tests/kraken/driver.html?testName=ai-astar) 12:08:03 INFO - PROCESS | 4253 | RSS: Main: 246378496 12:08:03 INFO - PROCESS | 4253 | 12:08:03 INFO - PROCESS | 4253 | __start_tp_report 12:08:03 INFO - PROCESS | 4253 | _x_x_mozilla_page_load 12:08:03 INFO - PROCESS | 4253 | _x_x_mozilla_page_load_details 12:08:03 INFO - PROCESS | 4253 | |i|pagename|runs| 12:08:03 INFO - PROCESS | 4253 | |0;ai-astar;103;111;112;111;112;113;112;110;111;110 12:08:03 INFO - PROCESS | 4253 | |1;audio-beat-detection;140;122;120;151;116;116;115;116;132;116 12:08:03 INFO - PROCESS | 4253 | |2;audio-dft;160;161;160;160;161;161;162;163;162;161 12:08:03 INFO - PROCESS | 4253 | |3;audio-fft;75;74;75;101;75;76;75;75;89;75 12:08:03 INFO - PROCESS | 4253 | |4;audio-oscillator;83;82;107;82;83;82;92;82;81;109 12:08:03 INFO - PROCESS | 4253 | |5;imaging-gaussian-blur;113;113;113;112;112;113;113;113;113;112 12:08:03 INFO - PROCESS | 4253 | |6;imaging-darkroom;146;147;148;147;146;146;147;146;146;146 12:08:03 INFO - PROCESS | 4253 | |7;imaging-desaturate;95;94;94;94;93;93;94;94;94;94 12:08:03 INFO - PROCESS | 4253 | |8;json-parse-financial;56;53;54;54;54;55;54;55;55;54 12:08:03 INFO - PROCESS | 4253 | |9;json-stringify-tinderbox;53;52;53;54;53;54;53;53;53;53 12:08:03 INFO - PROCESS | 4253 | |10;stanford-crypto-aes;79;80;76;76;78;79;81;75;78;79 12:08:03 INFO - PROCESS | 4253 | |11;stanford-crypto-ccm;140;125;122;120;120;120;136;121;166;122 12:08:03 INFO - PROCESS | 4253 | |12;stanford-crypto-pbkdf2;162;159;162;166;157;158;162;159;160;159 12:08:03 INFO - PROCESS | 4253 | |13;stanford-crypto-sha256-iterative;62;60;60;59;65;61;58;58;61;57 12:08:03 INFO - PROCESS | 4253 | __end_tp_report 12:08:03 INFO - PROCESS | 4253 | __start_cc_report 12:08:03 INFO - PROCESS | 4253 | _x_x_mozilla_cycle_collect,1659 12:08:03 INFO - PROCESS | 4253 | __end_cc_report 12:08:03 INFO - PROCESS | 4253 | __startTimestamp1494961683918__endTimestamp 12:08:03 INFO - PROCESS | 4253 | 12:08:03 INFO - PROCESS | 4253 | ------- Summary: start ------- 12:08:03 INFO - PROCESS | 4253 | Number of tests: 14 12:08:03 INFO - PROCESS | 4253 | 12:08:03 INFO - PROCESS | 4253 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.50 stddev:2.80 (2.5%) stddev-sans-first:1.00 12:08:03 INFO - PROCESS | 4253 | Values: 103.0 111.0 112.0 111.0 112.0 113.0 112.0 110.0 111.0 110.0 12:08:03 INFO - PROCESS | 4253 | 12:08:03 INFO - PROCESS | 4253 | [#1] audio-beat-detection Cycles:10 Average:124.40 Median:121.00 stddev:12.49 (10.3%) stddev-sans-first:11.91 12:08:03 INFO - PROCESS | 4253 | Values: 140.0 122.0 120.0 151.0 116.0 116.0 115.0 116.0 132.0 116.0 12:08:03 INFO - PROCESS | 4253 | 12:08:03 INFO - PROCESS | 4253 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:0.97 12:08:03 INFO - PROCESS | 4253 | Values: 160.0 161.0 160.0 160.0 161.0 161.0 162.0 163.0 162.0 161.0 12:08:03 INFO - PROCESS | 4253 | 12:08:03 INFO - PROCESS | 4253 | [#3] audio-fft Cycles:10 Average:79.00 Median:75.00 stddev:8.91 (11.9%) stddev-sans-first:9.33 12:08:03 INFO - PROCESS | 4253 | Values: 75.0 74.0 75.0 101.0 75.0 76.0 75.0 75.0 89.0 75.0 12:08:03 INFO - PROCESS | 4253 | 12:08:03 INFO - PROCESS | 4253 | [#4] audio-oscillator Cycles:10 Average:88.30 Median:82.00 stddev:10.85 (13.2%) stddev-sans-first:11.34 12:08:03 INFO - PROCESS | 4253 | Values: 83.0 82.0 107.0 82.0 83.0 82.0 92.0 82.0 81.0 109.0 12:08:03 INFO - PROCESS | 4253 | 12:08:03 INFO - PROCESS | 4253 | [#5] imaging-gaussian-blur Cycles:10 Average:112.70 Median:113.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 12:08:03 INFO - PROCESS | 4253 | Values: 113.0 113.0 113.0 112.0 112.0 113.0 113.0 113.0 113.0 112.0 12:08:03 INFO - PROCESS | 4253 | 12:08:03 INFO - PROCESS | 4253 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 12:08:03 INFO - PROCESS | 4253 | Values: 146.0 147.0 148.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 12:08:03 INFO - PROCESS | 4253 | 12:08:03 INFO - PROCESS | 4253 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 12:08:03 INFO - PROCESS | 4253 | Values: 95.0 94.0 94.0 94.0 93.0 93.0 94.0 94.0 94.0 94.0 12:08:03 INFO - PROCESS | 4253 | 12:08:03 INFO - PROCESS | 4253 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.50 stddev:0.84 (1.5%) stddev-sans-first:0.67 12:08:03 INFO - PROCESS | 4253 | Values: 56.0 53.0 54.0 54.0 54.0 55.0 54.0 55.0 55.0 54.0 12:08:03 INFO - PROCESS | 4253 | 12:08:03 INFO - PROCESS | 4253 | [#9] json-stringify-tinderbox Cycles:10 Average:53.10 Median:53.00 stddev:0.57 (1.1%) stddev-sans-first:0.60 12:08:03 INFO - PROCESS | 4253 | Values: 53.0 52.0 53.0 54.0 53.0 54.0 53.0 53.0 53.0 53.0 12:08:03 INFO - PROCESS | 4253 | 12:08:03 INFO - PROCESS | 4253 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:79.00 stddev:1.91 (2.4%) stddev-sans-first:2.00 12:08:03 INFO - PROCESS | 4253 | Values: 79.0 80.0 76.0 76.0 78.0 79.0 81.0 75.0 78.0 79.0 12:08:03 INFO - PROCESS | 4253 | 12:08:03 INFO - PROCESS | 4253 | [#11] stanford-crypto-ccm Cycles:10 Average:129.20 Median:123.50 stddev:14.76 (11.9%) stddev-sans-first:15.12 12:08:03 INFO - PROCESS | 4253 | Values: 140.0 125.0 122.0 120.0 120.0 120.0 136.0 121.0 166.0 122.0 12:08:03 INFO - PROCESS | 4253 | 12:08:03 INFO - PROCESS | 4253 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.40 Median:161.00 stddev:2.63 (1.6%) stddev-sans-first:2.73 12:08:03 INFO - PROCESS | 4253 | Values: 162.0 159.0 162.0 166.0 157.0 158.0 162.0 159.0 160.0 159.0 12:08:03 INFO - PROCESS | 4253 | 12:08:03 INFO - PROCESS | 4253 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.10 Median:60.50 stddev:2.33 (3.9%) stddev-sans-first:2.37 12:08:03 INFO - PROCESS | 4253 | Values: 62.0 60.0 60.0 59.0 65.0 61.0 58.0 58.0 61.0 57.0 12:08:03 INFO - PROCESS | 4253 | -------- Summary: end -------- 12:08:03 INFO - PROCESS | 4253 | 12:08:04 INFO - TEST-INFO | 4253: exit 0 12:08:04 INFO - TEST-OK | kraken | took 60103ms 12:08:04 INFO - SUITE-END | took 1176s 12:08:05 INFO - Completed test suite (00:19:36) 12:08:05 INFO - javascript benchmark 12:08:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7996.402714962422, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3420.7947523148614, 3428.8799892003767, 3440.7935523868555, 3450.361683088629, 3470.357983773002, 5620.91568626471, 5719.485246327829, 5789.623674461157, 5790.797322093733, 5813.825585232439, 5782.624129431584, 5818.2145410369585, 5842.415758424156, 5859.32617748959, 5882.823515294548, 5264.921026184601, 5274.0, 5294.682319060868, 5363.222332761748, 5390.78436862525, 5111.335526381566, 5378.273933019032, 5380.112281473552, 5389.353277606673, 5389.649672771257, 5164.070467315882, 5244.239585260135, 5316.4683531646715, 5326.840194794162, 5337.306150200468, 5382.3541175059045, 5409.459054094598, 5417.322834645669, 5421.674699518042, 5424.83725488234, 5304.708241046741, 5331.280277162611, 5338.679679219259, 5361.061814182542, 5393.703346315951, 5650.124230744241, 5661.122526008476, 5692.203091567184, 5771.769129234825, 5838.737256823453, 6252.874942501125, 6256.468200202989, 6260.15487909131, 6264.029075493306, 6271.310155882895, 6307.369263073701, 6313.494920406402, 6313.589616674947, 6315.684215789192, 6318.620882747004, 5699.202111704323, 5703.17303990919, 5745.798897038667, 5749.453801888856, 5858.502027327682, 6231.501479881598, 6275.090111933744, 6276.340984196685, 6279.529035322369, 6285.0, 5995.310539287951, 6000.939990600125, 6014.849628759316, 6021.548383871227, 6028.788992385245, 5965.13505541694, 5996.2504686914135, 6133.3866613338305, 6140.815775526741, 6146.508279337642, 6111.561351782736, 6128.1114238435175, 6128.203333566607, 6140.631562106288, 6144.016957286813, 5958.910616340759, 5986.2217911671205, 5991.191189189403, 5996.430339117776, 6177.320494745574, 4644.047970166108, 4658.767061646904, 4667.136579732693, 4667.509911459316, 4673.205555055649, 4239.427677263591, 4252.064545799919, 4252.234597772431, 4295.269804133305, 4296.2481565725875, 5881.235439392852, 5895.528357731371, 6074.726637301332, 6100.542459315569, 6109.877802444015, 6258.530610204253, 6270.184875966095, 6292.150559674477, 6301.4328710416285, 6321.1150438938585, 6110.7861224856915, 6112.419320164578, 6129.509639228851, 6131.601445906002, 6133.202683651097, 5175.689458632494, 5209.843704688866, 5290.894182116336, 5293.920591191135, 5307.124324486494, 6452.290248072708, 6501.869962600722, 6513.4463570595135, 6517.055027021151, 6520.347965203442, 6145.324014358506, 6231.501479881508, 6231.844203894758, 6246.187995560548, 6257.655828929453, 6668.133142691419, 6712.966435167793, 6714.026466162477, 6719.395254427125, 6725.9663701681175, 5931.6441013539325, 6187.226596675416, 6190.969045154746, 6193.38066193377, 6195.566310358412, 6134.589663226307, 6187.071939208975, 6233.844153896189, 6239.344868788893, 6258.374162583706, 6070.7875224366935, 6175.84560385976, 6186.938130618816, 6193.163922870355, 6201.10084037821, 6177.660228687465, 6180.6600636965395, 6184.319724830175, 6187.628742275478, 6191.907121393093, 5946.5540084494705, 6008.369121242206, 6024.668643224665, 6036.547258955684, 6125.173101631222, 5916.437938395846, 5919.970400147971, 6181.196444462371, 6205.0, 6205.751769929152, 5842.503387211965, 5875.588708790344, 5877.0, 5878.970605146947, 5944.286685597756], "value": 5744.094800210244, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [756.4742503959747, 838.1995194589166, 860.6772460327377, 908.4821651658553, 931.017776246061, 33551.66448335516, 44331.55668443315, 45451.318230226534, 49453.0, 49543.256851147264, 45056.09887802242, 45231.321530177076, 45359.54640453595, 45393.31910021352, 45428.545714542845, 7608.847823043536, 7778.5721785301785, 9257.074292570756, 9387.389819661734, 9413.62345506179, 10801.729956751065, 11068.446577671124, 11357.318560886331, 11373.715657108598, 11376.715582110432, 11079.335239885593, 11122.944385278062, 11126.054285385751, 11126.721831954226, 11127.554897804119, 11092.667219983414, 11095.500702468367, 11097.0, 11101.777964440747, 11128.942750438695, 10770.299930504492, 10842.349459032404, 10854.72863178419, 10856.077233435088, 10869.184811139196, 42344.36483452751, 42549.787251063855, 42582.78708606468, 42615.0, 42630.78684606588, 4243.236217480852, 4285.892852678677, 4293.592108749664, 4373.825046998117, 4431.49037860647, 30333.0, 31289.843550782327, 31359.529607055912, 32024.199395015312, 32532.512012319836, 4403.185410698999, 4425.1149770045795, 4520.094845278667, 4520.186366454037, 4529.6062819065455, 242965.0, 243176.0, 244083.0, 244827.0, 244927.99999999822, 54661.45338546643, 54693.453065468835, 54861.725691371284, 54939.725301374034, 54951.17573236405, 57397.71301143467, 57822.7108864453, 57903.71048144732, 57928.71035644795, 57980.71009644925, 16604.418845340355, 16676.916615416845, 16698.0, 16700.248488818033, 16700.58248543796, 12729.363531823372, 13008.154469959421, 14713.632159195891, 14715.0, 14848.554543363716, 14136.787948180785, 14146.85853141476, 14155.64610884736, 14173.149611023371, 14269.215193164475, 5367.141257398797, 5386.596005299618, 5434.809781657623, 5528.502434780889, 5569.860753481195, 991.3011327014582, 998.256299057207, 999.2605471950704, 1010.888802231754, 1030.0935177044153, 27472.0, 28393.722282497336, 28520.0, 28780.424391512053, 28781.0, 1311.9934400328127, 1314.5530519623182, 1326.8341457317836, 1341.8255626768653, 1342.6978929740926, 13453.394597243148, 13914.30428478572, 14200.85799142016, 14217.289135543182, 14390.208538530273, 326692.0, 333582.0, 333860.0, 333888.0, 334168.0, 52407.73796130995, 52644.473555264725, 52697.999999999236, 52753.47246527563, 52780.20829687558, 1434.619825746178, 1494.7010597880467, 1497.663025819182, 1502.4966636177003, 1506.7664512000658, 27996.30009249785, 28549.857250713612, 29175.1247462568, 29365.853170734008, 29488.705112949454, 37661.05847353728, 37896.81051594725, 37910.62089379181, 37921.0, 37967.62032379641, 295756.0, 297668.0, 297852.0, 297960.0, 298658.0, 24573.0, 25015.12447064344, 29198.56202157012, 29933.102006939826, 30035.249118772204, 39311.41032884566, 39490.0, 39641.40537891876, 40014.79992600018, 40487.595124048385, 31363.84318078395, 31513.0, 31695.36609267848, 31696.683033170295, 32163.839180803945, 30990.69009309878, 31138.532922005736, 31230.21924451907, 31395.372092557565, 31963.0, 35159.47260791141, 35386.0, 35590.8220458896, 35906.28187436289, 35951.0, 29597.556036659036, 29757.0, 29883.25291867634, 30154.0, 30168.698313017467, 23262.883685581462, 23669.526609467368, 23953.64069538993, 24361.26916192517, 24716.38209044788], "value": 18976.471968196027, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [460.2130357089377, 465.74151346002975, 472.8581425572327, 477.55110196415364, 479.4582122201911, 20450.89774551127, 21704.674429883526, 21881.890590547064, 22251.44371390716, 22306.21928232512, 23243.65134522979, 23526.411839704015, 23771.405714857137, 23778.76221237787, 23936.8803155984, 5472.015037293286, 6805.251422343551, 7054.294570542956, 7093.397061249774, 7138.036365090698, 6775.254721980578, 6897.551659142165, 6905.896411553831, 7013.473989450812, 7025.894611580805, 6967.721291148373, 6968.512204145712, 6977.406920411746, 6982.19704733957, 6984.1619005719385, 6875.48433867462, 6938.340857618544, 6958.756443524478, 6969.16370035599, 6972.686229119651, 6733.49498787588, 6801.353871382211, 6815.352541508599, 6818.761343353009, 6848.931510684879, 26690.0, 26705.866470667523, 26707.19878403651, 26841.0, 27003.72996270032, 3094.210976201054, 3242.5784647995847, 3543.7165026797793, 3738.6261373862667, 3752.605976372496, 16472.176391180394, 16599.50201493957, 16628.916855415766, 17132.486025419257, 17227.913860430745, 2308.9307320780235, 2418.9153379631803, 2538.7588179122954, 2576.304397812599, 2587.870606469669, 114881.0, 118463.0, 119067.0, 119259.4037029818, 119648.0, 17894.373696920546, 18167.63664726698, 18463.0, 18819.0, 18990.52523686891, 31681.36637267242, 31832.681673183433, 31867.681323186473, 31874.20314492156, 31904.68095319017, 10739.248252622241, 10916.0, 10925.235233533576, 10967.725806854733, 11124.165687573464, 9192.908070919206, 9204.539773011322, 9223.584938677775, 9397.107274808883, 9412.482313472825, 9063.229625481908, 9338.673146439842, 9424.62301507932, 9530.52347382628, 9664.130228279348, 3726.3851464508593, 3895.9805200973815, 3935.9212815743526, 3989.813242784369, 4009.5990400960254, 1175.5767923547517, 1187.5012494752225, 1194.892459678633, 1200.8498937632796, 1214.5566868093258, 20606.58786824255, 20769.58460830775, 20773.376798696063, 20932.0, 21030.263940762, 1045.7019749371393, 1123.4719681749564, 1196.5154112584416, 1224.7366816134574, 1247.1457051919465, 10773.676789696165, 11304.943475282571, 11326.603568875049, 11338.943305283421, 11375.20373573842, 726777.0, 737041.0, 745228.0, 756134.0, 774403.0, 79261.20738792654, 80805.0, 86765.0, 96814.51592741991, 109364.0, 1253.8307328510716, 1310.6592286005707, 1329.7805862032656, 1345.3407830163148, 1352.776791829337, 19614.705779413034, 19818.50453738668, 20072.59854802925, 20087.59824803525, 20197.798022019593, 53056.0, 53169.0, 54010.45989540054, 54230.728846355516, 54350.0, 70397.64801175961, 70643.64678176782, 70726.6463667699, 71102.64448677724, 73232.90150647638, 12282.201656892274, 12535.749285014066, 12610.117291789487, 12790.168639038433, 12855.87144128584, 13531.864681353061, 13769.31153442344, 13824.0, 14022.368993395117, 14393.064450810663, 12503.187292825936, 12526.937365313115, 12562.811557826823, 12567.308798016196, 12725.363731813557, 10560.524776384927, 11409.087273018305, 11749.0, 11762.58830940913, 12163.878361216275, 6832.4776952599705, 7484.962575187089, 12425.62723118308, 12825.551105711254, 12876.291803950498, 12174.513019479122, 12235.143539952118, 12338.321392323509, 12370.42807734844, 12638.0, 11804.527818887149, 12244.816327755269, 12256.938715306724, 12453.501859925502, 12502.374881255719], "value": 11755.758681239826, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1591.5861875912274, 1598.9520314390566, 1609.7665838453422, 1612.7903372561566, 1624.6019725167328, 11153.776924461506, 11987.940060299698, 11995.2203106798, 12017.098717596193, 12031.75936481271, 11221.270617409884, 11626.186166968315, 11665.183437159401, 11666.941665291663, 11672.47473863676, 2472.258322503251, 2508.147229941819, 2508.2976766505317, 2510.447701505675, 2515.4591762771, 2492.3519884829984, 2530.278870521902, 2543.631173479844, 2573.5496288149593, 2573.9742602574015, 2370.1230544698487, 2394.2577800881695, 2489.2905521926255, 2573.6654234949524, 2577.3170109920884, 2418.9274321770285, 2464.7904928081134, 2474.8762561871836, 2500.3124140861228, 2525.4065294655743, 2457.619069044283, 2474.3937735254976, 2482.15606693725, 2487.3905893056135, 2489.2283392148493, 11597.536098556047, 11763.411829408495, 11804.881951180465, 11839.408029598486, 11847.822282665767, 6038.305594856603, 6152.3847615238565, 6172.321044685081, 6178.752849885999, 6195.504359651217, 3705.0, 3777.1501412182315, 3790.033541446913, 3864.516935383077, 3915.0408150003145, 1434.6700258940398, 1450.4705782389458, 1487.1820498725658, 1515.1893736850732, 1526.5496678479876, 15513.146776927264, 16056.759148612664, 17247.0, 17852.285908563772, 17853.821461785345, 4904.6566740327835, 5084.694918304914, 5169.224616307584, 5181.818636347785, 5197.0, 13571.0, 13572.117812342363, 13574.389152488162, 13576.93211533936, 13586.660333491543, 6197.597156184834, 6203.47270482005, 6210.782622608187, 6212.689365531705, 6216.595921265103, 5449.6730196188355, 5651.491365777099, 5714.200011998323, 5774.0, 5785.247917770747, 4093.207968190158, 4127.926739047809, 4159.292920203573, 4171.0823618803815, 4205.495340559152, 1072.8068947589352, 1073.8550295710136, 1085.7122862441458, 1103.4813637590319, 1106.75651356703, 1084.5173897615484, 1087.4399684162663, 1095.2771171027084, 1098.983515247272, 1116.079234631416, 6717.875018583695, 6889.173299204128, 6900.930990690129, 7372.705091796268, 7427.8143046424275, 1042.994785026085, 1060.7189094889861, 1061.6549621373085, 1079.1312993040522, 1093.7429704019548, 4597.264437689953, 4823.469418363977, 4898.044881248123, 4960.181570040975, 4969.652124351333, 13813.447462101605, 14366.784498232535, 14760.409583616534, 14828.555143345717, 14845.0, 14444.638884027772, 14583.0, 14650.487232946796, 14680.0, 14680.0, 10695.572177112985, 10755.731106722238, 10872.18458615607, 11029.062529684907, 11040.558377664964, 6077.301110372364, 7325.670344834602, 7378.372838308589, 7566.659500322388, 7710.11333696632, 13050.15174013686, 13066.54267100647, 13160.14459060158, 13255.933720331337, 13280.136791108547, 13078.542251021168, 13191.736165276448, 13238.4042718076, 13265.336733163496, 13339.266340351374, 10428.113610343205, 10521.894781052091, 10602.0, 10620.575176992834, 10628.52171652262, 11352.148588855704, 11374.601888933848, 11503.194776365908, 11569.0, 11691.181617286707, 9883.456409897524, 9921.305508614329, 9941.0, 10050.69847904564, 10167.898321016992, 9517.428954262767, 9549.665761698307, 9590.856137158087, 9619.855702164334, 9889.85165222508, 8893.822123557364, 9041.728748137566, 9057.320700947323, 9068.0, 9079.45523268606, 6373.74505019794, 6430.0, 6448.419642232034, 6457.515686323451, 6499.5125365598715, 6659.067730517828, 6687.921702380108, 6692.5649832762665, 6742.662866856539, 6867.038614594061], "value": 5601.241377812495, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.6917369864657, 401.49211247771575, 417.6011908627261, 433.1337325349301, 434.8521502689086, 5179.715115668641, 5221.765020574074, 5233.450487698789, 5238.580913526918, 5242.0, 4942.159832828419, 5064.594832413407, 5065.873353166173, 5110.8466745997675, 5170.896582068356, 4508.842190523333, 4517.576963256572, 4518.887027824314, 4532.773361331937, 4543.227651299287, 4536.931946020813, 4542.136993971135, 4550.613197878184, 4571.3600095986585, 4574.359589657451, 4340.370646256291, 4509.301058335963, 4534.251848445003, 4545.477270113946, 4559.703619264754, 4492.39352687388, 4521.276595744698, 4525.660575456854, 4536.296873984521, 4537.455505339381, 4353.564643535653, 4369.366441865944, 4375.628071613916, 4380.102079073782, 4403.801828917674, 5030.459617892977, 5089.491050894918, 5128.897422051538, 5145.6398052136365, 5207.09940871583, 5189.714565698885, 5215.739213039333, 5228.816991405321, 5250.5274525292525, 5268.050821196143, 5433.864153396157, 5477.260569823103, 5479.315085614298, 5495.670259784426, 5500.862478438071, 4631.374764406829, 4778.331033655291, 4813.566778989873, 4816.325714399987, 4851.393575803025, 5441.238226648273, 5534.1975413565215, 5585.301837270341, 5626.9437305626825, 5676.631018983753, 4938.851834444972, 4943.332650092191, 4971.353724015855, 4976.570851941775, 4992.151334273182, 4865.70805751656, 4904.792843220565, 4966.304717339575, 5079.958608485252, 5141.529467609349, 5121.667091639031, 5155.561777248976, 5175.4824517548695, 5191.273221748958, 5195.272661827347, 5318.601104917069, 5446.373667028342, 5454.481824226692, 5475.425080366584, 5485.314335708036, 1675.9497215083568, 1720.5698575356162, 1724.1982478147722, 1749.7375393691048, 1770.8406243438153, 1429.5490077571067, 1435.526276328809, 1442.235615123986, 1460.2406748490725, 1484.3320505772447, 5403.567714582824, 5427.348718153768, 5496.615236933456, 5515.476029777245, 5550.583706221969, 5280.254267780732, 5557.333120025542, 5572.523281330451, 5584.664920104726, 5685.744141513642, 5440.93244567062, 5442.755076021588, 5445.665811876116, 5451.863703407367, 5507.394186639466, 2822.407294468144, 2844.672862620825, 2904.4191161767308, 2947.1747910585073, 2954.926126846803, 5704.80033198836, 5784.971075144597, 5797.449242321973, 5838.824835254949, 5865.970670146622, 5581.748821303051, 5665.858353541194, 5668.0, 5686.886262274731, 5726.627769194989, 5569.554435645138, 5792.21805056312, 5857.912131318119, 5875.588708790429, 5878.500982249585, 5455.399906010415, 5468.0, 5528.308961379827, 5529.640573362719, 5541.3904470509015, 5239.030779305841, 5377.891003546568, 5416.458354164552, 5462.8361149165585, 5497.670139791625, 5845.240118784531, 5896.0, 5900.262467191601, 5915.733791979457, 5917.940820591739, 4485.237509623437, 4685.67200295976, 4977.129002424489, 4994.275830004702, 5000.374953130859, 5555.638883472561, 5568.132411807841, 5585.916211256753, 5593.916091258716, 5598.0, 5444.482774136451, 5449.073657478318, 5477.808276710296, 5502.697351645698, 5514.5864060194845, 5223.425423203521, 5435.646682965595, 5446.264754258283, 5446.455354464521, 5462.235287059894, 5411.186183184801, 5428.59285553593, 5428.828468612586, 5443.292371991616, 5458.563314934875, 5380.483349864003, 5470.261514695465, 5494.615376923577, 5536.640118392292, 5609.0, 5248.868778280574, 5261.158214685632, 5320.787168513371, 5342.198670199501, 5343.599230057684], "value": 4479.798743809588, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [852.0542198160045, 887.2680038967853, 922.8154369126174, 926.5459924636925, 935.854942483915, 17439.65120697587, 18517.2593096276, 18975.71536426955, 19220.711689324635, 19323.227070917164, 16569.0, 16700.08149551774, 16832.158392080408, 17560.121993900317, 17701.55746106348, 885.8405487012335, 913.8446464101119, 931.8695382646434, 942.420411446962, 946.191006689281, 914.7530166854946, 917.1516347378681, 917.3074328881685, 917.6421195733669, 917.8439665256923, 977.0766625538869, 979.3095867413457, 980.0738302304326, 980.1717548671361, 980.5097451274363, 968.8934217236099, 974.0357046523891, 975.7853272280087, 975.8194733974202, 977.3598293117948, 717.4834119433999, 718.2171433137905, 719.7732714195012, 720.4452571519953, 720.4920531025614, 18661.440156795317, 18704.345347912757, 19030.238790448366, 19719.80280197194, 19934.401967940987, 16614.83385166145, 16815.579610509714, 16950.745738813926, 17062.402815901507, 17679.116044197737, 13311.534096306583, 13842.930785346109, 14261.286935653176, 14334.856651433456, 14377.0, 4975.7263350515705, 5005.799768009275, 5118.539331460186, 5169.508896654812, 5296.3379577552805, 80960.59519702423, 81288.59355703184, 83124.0, 83166.0, 84000.57999709963, 12624.684382890502, 12770.680732981564, 12793.168444051107, 12970.870291296966, 13039.478420863059, 22772.836580524825, 23168.304950851503, 23238.419039523807, 23246.070157193863, 23405.648915266283, 8987.685431009882, 9106.18044375996, 9107.08929107084, 9136.81726365469, 9173.724788256362, 5120.615953803405, 5183.248428977777, 5209.29674493946, 5237.895242095136, 5369.328833895763, 3690.0, 3784.3377408953875, 3791.3175628387157, 3801.2967600993907, 3820.3887378019385, 618.4186864347499, 631.311870061635, 637.7704026550438, 640.6924676155378, 643.3277225299573, 687.7730348984823, 702.8734827730955, 724.8577416897703, 725.8911163325544, 734.8793090536974, 11184.655138143542, 11195.496202670736, 11302.321860688386, 11589.188756787113, 11726.824097638542, 628.2868943748787, 629.6725702634604, 640.385230179024, 642.6915080761261, 661.3188415931598, 5254.842354729364, 5452.093373792596, 5563.66618002913, 5580.609357344947, 5583.497485226349, 85452.14547854566, 85761.57119214365, 85993.57003214944, 86838.56580717055, 89059.0, 71381.0, 71603.6419817908, 71689.2831071693, 71992.64003679948, 72944.0, 65881.0, 66035.66982165155, 66088.0, 68775.65612171908, 68965.31034689689, 10604.628837990942, 10742.570297188338, 11023.503942322453, 11051.889481105087, 11063.72340691489, 46435.53564464312, 46923.296150557086, 47043.29435058546, 47854.760726196146, 47930.281045785036, 51321.486785133166, 51462.0, 55306.72346638402, 57303.71348143233, 57579.712101439225, 13858.0, 14046.929765351108, 14120.152790832582, 14755.926220368829, 14927.253637318308, 16219.594510137342, 16229.350825966829, 16512.83487165113, 17186.484405467854, 17201.913990429966, 16239.269232884311, 16675.49973500797, 17159.0, 17407.129643518027, 17428.128593570524, 14889.255537222878, 15376.46182383656, 15393.538193854203, 15482.612934676723, 15627.76558351603, 15719.21403929776, 15821.367145314058, 15863.20683965774, 15956.0, 15994.680106397574, 11420.428978551205, 11425.485853136795, 11842.0, 12057.638270851889, 12164.75670486603, 13068.477260909458, 13262.20426774358, 13349.0, 13362.265075420944, 13427.26150061756], "value": 8130.17630706838, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1451.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 112.0, 111.0, 112.0, 113.0, 112.0, 110.0, 111.0, 110.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 122.0, 120.0, 151.0, 116.0, 116.0, 115.0, 116.0, 132.0, 116.0], "value": 124.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 160.0, 161.0, 161.0, 162.0, 163.0, 162.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 101.0, 75.0, 76.0, 75.0, 75.0, 89.0, 75.0], "value": 79.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 107.0, 82.0, 83.0, 82.0, 92.0, 82.0, 81.0, 109.0], "value": 88.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 112.0, 112.0, 113.0, 113.0, 113.0, 113.0, 112.0], "value": 112.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 93.0, 93.0, 94.0, 94.0, 94.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 54.0, 54.0, 54.0, 55.0, 54.0, 55.0, 55.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 54.0, 53.0, 54.0, 53.0, 53.0, 53.0, 53.0], "value": 53.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 76.0, 76.0, 78.0, 79.0, 81.0, 75.0, 78.0, 79.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 125.0, 122.0, 120.0, 120.0, 120.0, 136.0, 121.0, 166.0, 122.0], "value": 129.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 162.0, 166.0, 157.0, 158.0, 162.0, 159.0, 160.0, 159.0], "value": 160.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 60.0, 59.0, 65.0, 61.0, 58.0, 58.0, 61.0, 57.0], "value": 60.1, "unit": "score"}]}]} 12:08:05 INFO - Return code: 0 12:08:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:08:05 INFO - # TBPL SUCCESS # 12:08:05 INFO - Running post-action listener: _resource_record_post_action 12:08:05 INFO - [mozharness: 2017-05-16 19:08:05.256773Z] Finished run-tests step (success) 12:08:05 INFO - Running post-run listener: _resource_record_post_run 12:08:05 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 326123520; Read time: 0; Write time: 203952 12:08:05 INFO - TinderboxPrint: CPU usage
13.1% 12:08:05 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 12:08:05 INFO - TinderboxPrint: I/O write bytes / time
326,123,520 / 203,952 12:08:05 INFO - TinderboxPrint: CPU idle
8,261.1 (86.9%) 12:08:05 INFO - TinderboxPrint: CPU user
1,199.9 (12.6%) 12:08:05 INFO - TinderboxPrint: Swap in / out
0 / 0 12:08:05 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 44011520; Read time: 0; Write time: 15388 12:08:05 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 227106816; Read time: 0; Write time: 106648 12:08:05 INFO - Running post-run listener: _upload_blobber_files 12:08:05 INFO - Blob upload gear active. 12:08:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:08:05 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 12:08:05 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'] 12:08:05 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 12:08:06 INFO - (blobuploader) - INFO - Open directory for files ... 12:08:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:08:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:08:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:08:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:08:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:08:07 INFO - (blobuploader) - INFO - Done attempting. 12:08:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:08:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:08:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:08:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:08:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:08:08 INFO - (blobuploader) - INFO - Done attempting. 12:08:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:08:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:08:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:08:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:08:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:08:11 INFO - (blobuploader) - INFO - Done attempting. 12:08:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:08:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:08:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:08:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:08:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:08:11 INFO - (blobuploader) - INFO - Done attempting. 12:08:11 INFO - (blobuploader) - INFO - Iteration through files over. 12:08:11 INFO - Return code: 0 12:08:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:08:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:08:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ccc4958718fb9e4805232ad9c659dd321ad1b1aa5baa6d7824df54c832f86766bdbd5f88d83c9a245069ec341e1bbeacc80ec839eb199c16249b5eea7d02f050", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/cb5dcf5050643db0e03c215ed0d263927c7b31f6e757b83b6635ac8dddbab75563b056ddb2dfbdd345876f7b46c9346f1d86195d8b86c67fd1baa6e48ee765e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4a33b5b0760ac8f514a6612f078048750a61b1babb895db425330640ab24756a206b92b61fd1ca681712be5ef79aaf4c24d08c22749e52b58153d37a33dd4742", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/af6c3232be1700422b6b2d2c7a4abdb18801c28eb60adc10ebead4e91887219930f7fddc4d984047b229f5f9690d8b9c1c8841d76b2afe4ba32ae6f89853e26c"} 12:08:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:08:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:08:11 INFO - Contents: 12:08:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ccc4958718fb9e4805232ad9c659dd321ad1b1aa5baa6d7824df54c832f86766bdbd5f88d83c9a245069ec341e1bbeacc80ec839eb199c16249b5eea7d02f050", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/cb5dcf5050643db0e03c215ed0d263927c7b31f6e757b83b6635ac8dddbab75563b056ddb2dfbdd345876f7b46c9346f1d86195d8b86c67fd1baa6e48ee765e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4a33b5b0760ac8f514a6612f078048750a61b1babb895db425330640ab24756a206b92b61fd1ca681712be5ef79aaf4c24d08c22749e52b58153d37a33dd4742", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/af6c3232be1700422b6b2d2c7a4abdb18801c28eb60adc10ebead4e91887219930f7fddc4d984047b229f5f9690d8b9c1c8841d76b2afe4ba32ae6f89853e26c"} 12:08:11 INFO - Running post-run listener: copy_logs_to_upload_dir 12:08:11 INFO - Copying logs to upload dir... 12:08:11 INFO - mkdir: /builds/slave/test/build/upload/logs 12:08:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.021881 ========= master_lag: 0.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-05-16 12:08:11.265314) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-16 12:08:11.269693) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1494959897.738146-2023400927 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/ccc4958718fb9e4805232ad9c659dd321ad1b1aa5baa6d7824df54c832f86766bdbd5f88d83c9a245069ec341e1bbeacc80ec839eb199c16249b5eea7d02f050", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/cb5dcf5050643db0e03c215ed0d263927c7b31f6e757b83b6635ac8dddbab75563b056ddb2dfbdd345876f7b46c9346f1d86195d8b86c67fd1baa6e48ee765e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4a33b5b0760ac8f514a6612f078048750a61b1babb895db425330640ab24756a206b92b61fd1ca681712be5ef79aaf4c24d08c22749e52b58153d37a33dd4742", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/af6c3232be1700422b6b2d2c7a4abdb18801c28eb60adc10ebead4e91887219930f7fddc4d984047b229f5f9690d8b9c1c8841d76b2afe4ba32ae6f89853e26c"} build_url:https://queue.taskcluster.net/v1/task/dvjEDvQKTyG_CQ-TmrKAvA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011183 build_url: 'https://queue.taskcluster.net/v1/task/dvjEDvQKTyG_CQ-TmrKAvA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ccc4958718fb9e4805232ad9c659dd321ad1b1aa5baa6d7824df54c832f86766bdbd5f88d83c9a245069ec341e1bbeacc80ec839eb199c16249b5eea7d02f050", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/cb5dcf5050643db0e03c215ed0d263927c7b31f6e757b83b6635ac8dddbab75563b056ddb2dfbdd345876f7b46c9346f1d86195d8b86c67fd1baa6e48ee765e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4a33b5b0760ac8f514a6612f078048750a61b1babb895db425330640ab24756a206b92b61fd1ca681712be5ef79aaf4c24d08c22749e52b58153d37a33dd4742", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/af6c3232be1700422b6b2d2c7a4abdb18801c28eb60adc10ebead4e91887219930f7fddc4d984047b229f5f9690d8b9c1c8841d76b2afe4ba32ae6f89853e26c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-16 12:08:11.297249) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 12:08:11.297648) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1494959897.738146-2023400927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004619 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 12:08:11.351335) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-16 12:08:11.351699) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-16 12:08:11.352040) ========= ========= Total master_lag: 0.26 =========