builder: mozilla-beta_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-012 starttime: 1495637255.9 results: success (0) revision: c58deb31c649510a264a7593359da8b910b01141 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-24 07:47:35.900770) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-24 07:47:35.901249) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-24 07:47:35.901538) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-24 07:47:35.914990) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 07:47:35.915398) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1495637255.841561-1340262720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-24 07:47:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|: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.7M=0s 2017-05-24 07:47:36 (42.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.135311 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 07:47:36.061365) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 07:47:36.061671) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1495637255.841561-1340262720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018960 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 07:47:36.111094) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 07:47:36.111430) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c58deb31c649510a264a7593359da8b910b01141 --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 c58deb31c649510a264a7593359da8b910b01141 --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=2c5dd2b0a310ecf02fd87158000001b4-1495637255.841561-1340262720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-24 07:47:36,673 truncating revision to first 12 chars 2017-05-24 07:47:36,673 Setting DEBUG logging. 2017-05-24 07:47:36,673 attempt 1/10 2017-05-24 07:47:36,673 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/c58deb31c649?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-24 07:47:37,153 unpacking tar archive at: mozilla-beta-c58deb31c649/testing/mozharness/ program finished with exit code 0 elapsedTime=0.768885 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 07:47:36.893721) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-24 07:47:36.894054) ========= script_repo_revision: c58deb31c649510a264a7593359da8b910b01141 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-24 07:47:36.894430) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-24 07:47:36.894794) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-24 07:47:36.904785) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-05-24 07:47:36.905165) ========= /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=2c5dd2b0a310ecf02fd87158000001b4-1495637255.841561-1340262720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:47:37 INFO - MultiFileLogger online at 20170524 07:47:37 in /builds/slave/test 07:47:37 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 07:47:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:47:37 INFO - {'append_to_log': False, 07:47:37 INFO - 'base_work_dir': '/builds/slave/test', 07:47:37 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 07:47:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:47:37 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 07:47:37 INFO - 'buildbot_json_path': 'buildprops.json', 07:47:37 INFO - 'config_files': ('talos/linux_config.py',), 07:47:37 INFO - 'default_actions': ('clobber', 07:47:37 INFO - 'read-buildbot-config', 07:47:37 INFO - 'download-and-extract', 07:47:37 INFO - 'populate-webroot', 07:47:37 INFO - 'create-virtualenv', 07:47:37 INFO - 'install', 07:47:37 INFO - 'run-tests'), 07:47:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:47:37 INFO - 'download_minidump_stackwalk': True, 07:47:37 INFO - 'download_symbols': 'ondemand', 07:47:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:47:37 INFO - 'tooltool.py': '/tools/tooltool.py', 07:47:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:47:37 INFO - '/tools/misc-python/virtualenv.py')}, 07:47:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:47:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:47:37 INFO - 'gecko_profile': False, 07:47:37 INFO - 'gecko_profile_interval': 0, 07:47:37 INFO - 'installer_path': 'installer.exe', 07:47:37 INFO - 'log_level': 'info', 07:47:37 INFO - 'log_name': 'talos', 07:47:37 INFO - 'log_to_console': True, 07:47:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:47:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:47:37 INFO - 'opt_config_files': (), 07:47:37 INFO - 'pip_index': False, 07:47:37 INFO - 'suite': 'dromaeojs', 07:47:37 INFO - 'system_bits': '32', 07:47:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:47:37 INFO - 'title': 'talos-linux64-ix-012', 07:47:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:47:37 INFO - 'use_talos_json': True, 07:47:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:47:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:47:37 INFO - 'work_dir': 'build'} 07:47:37 INFO - [mozharness: 2017-05-24 14:47:37.565364Z] Running clobber step. 07:47:37 INFO - Running pre-action listener: _resource_record_pre_action 07:47:37 INFO - Running main action method: clobber 07:47:37 INFO - rmtree: /builds/slave/test/build 07:47:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:47:39 INFO - Running post-action listener: _resource_record_post_action 07:47:39 INFO - [mozharness: 2017-05-24 14:47:39.161368Z] Finished clobber step (success) 07:47:39 INFO - [mozharness: 2017-05-24 14:47:39.161466Z] Running read-buildbot-config step. 07:47:39 INFO - Running pre-action listener: _resource_record_pre_action 07:47:39 INFO - Running main action method: read_buildbot_config 07:47:39 INFO - Using buildbot properties: 07:47:39 INFO - { 07:47:39 INFO - "project": "", 07:47:39 INFO - "product": "firefox", 07:47:39 INFO - "who": "ryanvm@gmail.com", 07:47:39 INFO - "installer_path": "public/build/target.tar.bz2", 07:47:39 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 07:47:39 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta/", 07:47:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs", 07:47:39 INFO - "stage_platform": "linux64", 07:47:39 INFO - "basedir": "/builds/slave/test", 07:47:39 INFO - "buildnumber": 56, 07:47:39 INFO - "platform": "ubuntu64_hw", 07:47:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:47:39 INFO - "slavebuilddir": "test", 07:47:39 INFO - "taskId": "SIZJBJJKQyOGseTEYgKLbg", 07:47:39 INFO - "branch": "mozilla-beta", 07:47:39 INFO - "script_repo_revision": "production", 07:47:39 INFO - "revision": "c58deb31c649510a264a7593359da8b910b01141", 07:47:39 INFO - "slavename": "talos-linux64-ix-012", 07:47:39 INFO - "repo_path": "releases/mozilla-beta" 07:47:39 INFO - } 07:47:39 INFO - Finding installer, test and symbols from parent task. 07:47:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SIZJBJJKQyOGseTEYgKLbg'}, attempt #1 07:47:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SIZJBJJKQyOGseTEYgKLbg'}, attempt #1 07:47:40 INFO - Task dependencies: Sw4LfCkoRPCFVmByx_5YBQ 07:47:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Sw4LfCkoRPCFVmByx_5YBQ'}, attempt #1 07:47:40 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Sw4LfCkoRPCFVmByx_5YBQ/artifacts/public/build/target.tar.bz2 07:47:40 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Sw4LfCkoRPCFVmByx_5YBQ/artifacts/public/build/test_packages.json 07:47:40 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Sw4LfCkoRPCFVmByx_5YBQ/artifacts/public/build/target.crashreporter-symbols.zip 07:47:40 INFO - Running post-action listener: _resource_record_post_action 07:47:40 INFO - [mozharness: 2017-05-24 14:47:40.563889Z] Finished read-buildbot-config step (success) 07:47:40 INFO - [mozharness: 2017-05-24 14:47:40.564106Z] Running download-and-extract step. 07:47:40 INFO - Running pre-action listener: _resource_record_pre_action 07:47:40 INFO - Running main action method: download_and_extract 07:47:40 INFO - mkdir: /builds/slave/test/build/tests 07:47:40 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')]} 07:47:40 INFO - trying https://queue.taskcluster.net/v1/task/Sw4LfCkoRPCFVmByx_5YBQ/artifacts/public/build/target.test_packages.json 07:47:40 INFO - Downloading https://queue.taskcluster.net/v1/task/Sw4LfCkoRPCFVmByx_5YBQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:47:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Sw4LfCkoRPCFVmByx_5YBQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:47:41 INFO - Downloaded 986 bytes. 07:47:41 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:47:41 INFO - Using the following test package requirements: 07:47:41 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:47:41 INFO - u'common': [u'target.common.tests.zip'], 07:47:41 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:47:41 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:47:41 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:47:41 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:47:41 INFO - u'mozbase': [u'target.common.tests.zip'], 07:47:41 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:47:41 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:47:41 INFO - u'web-platform': [u'target.common.tests.zip', 07:47:41 INFO - u'target.web-platform.tests.zip'], 07:47:41 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:47:41 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:47:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Sw4LfCkoRPCFVmByx_5YBQ/artifacts/public/build/target.common.tests.zip 07:47:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Sw4LfCkoRPCFVmByx_5YBQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:47:41 INFO - Fetch https://queue.taskcluster.net/v1/task/Sw4LfCkoRPCFVmByx_5YBQ/artifacts/public/build/target.common.tests.zip into memory 07:47:42 INFO - Expected file size: 59712511 07:47:42 INFO - Obtained file size: 59712511 07:47:52 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:47:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Sw4LfCkoRPCFVmByx_5YBQ/artifacts/public/build/target.common.tests.zip 07:47:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Sw4LfCkoRPCFVmByx_5YBQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:47:52 INFO - Fetch https://queue.taskcluster.net/v1/task/Sw4LfCkoRPCFVmByx_5YBQ/artifacts/public/build/target.common.tests.zip into memory 07:47:53 INFO - Expected file size: 59712511 07:47:53 INFO - Obtained file size: 59712511 07:48:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Sw4LfCkoRPCFVmByx_5YBQ/artifacts/public/build/target.talos.tests.zip 07:48:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Sw4LfCkoRPCFVmByx_5YBQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:48:03 INFO - Fetch https://queue.taskcluster.net/v1/task/Sw4LfCkoRPCFVmByx_5YBQ/artifacts/public/build/target.talos.tests.zip into memory 07:48:04 INFO - Expected file size: 14404449 07:48:04 INFO - Obtained file size: 14404449 07: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')]} 07:48:04 INFO - trying https://queue.taskcluster.net/v1/task/Sw4LfCkoRPCFVmByx_5YBQ/artifacts/public/build/target.tar.bz2 07:48:04 INFO - Downloading https://queue.taskcluster.net/v1/task/Sw4LfCkoRPCFVmByx_5YBQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:48:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Sw4LfCkoRPCFVmByx_5YBQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:48:05 INFO - Downloaded 59761753 bytes. 07:48:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Sw4LfCkoRPCFVmByx_5YBQ/artifacts/public/build/target.tar.bz2 07:48:05 INFO - mkdir: /builds/slave/test/properties 07:48:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:48:05 INFO - Writing to file /builds/slave/test/properties/build_url 07:48:05 INFO - Contents: 07:48:05 INFO - build_url:https://queue.taskcluster.net/v1/task/Sw4LfCkoRPCFVmByx_5YBQ/artifacts/public/build/target.tar.bz2 07:48:05 INFO - Running post-action listener: _resource_record_post_action 07:48:05 INFO - Running post-action listener: set_extra_try_arguments 07:48:05 INFO - [mozharness: 2017-05-24 14:48:05.901851Z] Finished download-and-extract step (success) 07:48:05 INFO - [mozharness: 2017-05-24 14:48:05.901947Z] Running populate-webroot step. 07:48:05 INFO - Running pre-action listener: _resource_record_pre_action 07:48:05 INFO - Running main action method: populate_webroot 07:48:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:48:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:48:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:48:05 INFO - '--tppagecycles', 07:48:05 INFO - '7'], 07:48:05 INFO - 'tests': ['tsvgm']}}, 07:48:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:48:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:48:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:48:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:48:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:48:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:48:05 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:48:05 INFO - 'talos_options': ['--disable-e10s'], 07:48:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:48:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:48:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:48:05 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:48:05 INFO - 'talos_options': ['--disable-e10s'], 07:48:05 INFO - 'tests': ['damp', 'tps']}, 07:48:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:48:05 INFO - 'tests': ['damp', 'tps']}, 07:48:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:48:05 INFO - 'tests': ['dromaeo_dom']}, 07:48:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:48:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:48:05 INFO - 'tests': ['basic_compositor_video']}, 07:48:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:48:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:48:05 INFO - 'tests': ['a11yr', 07:48:05 INFO - 'ts_paint', 07:48:05 INFO - 'tpaint', 07:48:05 INFO - 'sessionrestore', 07:48:05 INFO - 'sessionrestore_no_auto_restore', 07:48:05 INFO - 'tabpaint']}, 07:48:05 INFO - 'other-e10s': {'tests': ['a11yr', 07:48:05 INFO - 'ts_paint', 07:48:05 INFO - 'tpaint', 07:48:05 INFO - 'sessionrestore', 07:48:05 INFO - 'sessionrestore_no_auto_restore', 07:48:05 INFO - 'tabpaint']}, 07:48:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:48:05 INFO - 'ts_paint', 07:48:05 INFO - 'tpaint', 07:48:05 INFO - 'sessionrestore', 07:48:05 INFO - 'sessionrestore_no_auto_restore', 07:48:05 INFO - 'tabpaint']}, 07:48:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:48:05 INFO - 'ts_paint', 07:48:05 INFO - 'tpaint', 07:48:05 INFO - 'sessionrestore', 07:48:05 INFO - 'sessionrestore_no_auto_restore', 07:48:05 INFO - 'tabpaint']}, 07:48:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:48:05 INFO - 'tests': ['a11yr', 07:48:05 INFO - 'ts_paint', 07:48:05 INFO - 'tpaint', 07:48:05 INFO - 'sessionrestore', 07:48:05 INFO - 'sessionrestore_no_auto_restore', 07:48:05 INFO - 'tabpaint']}, 07:48:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:48:05 INFO - 'tests': ['a11yr', 07:48:05 INFO - 'ts_paint', 07:48:05 INFO - 'tpaint', 07:48:05 INFO - 'sessionrestore', 07:48:05 INFO - 'sessionrestore_no_auto_restore', 07:48:05 INFO - 'tabpaint']}, 07:48:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:48:05 INFO - 'tests': ['tsvgx', 07:48:05 INFO - 'tsvgr_opacity', 07:48:05 INFO - 'tart', 07:48:05 INFO - 'tscrollx', 07:48:05 INFO - 'cart', 07:48:05 INFO - 'tsvg_static']}, 07:48:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:48:05 INFO - 'tsvgr_opacity', 07:48:05 INFO - 'tart', 07:48:05 INFO - 'tscrollx', 07:48:05 INFO - 'cart', 07:48:05 INFO - 'tsvg_static']}, 07:48:05 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:48:05 INFO - 'talos_options': ['--disable-e10s'], 07:48:05 INFO - 'tests': ['tp5o']}, 07:48:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:48:05 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:48:05 INFO - 'talos_options': ['--disable-e10s', 07:48:05 INFO - '--xperf_path', 07:48:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:48:05 INFO - 'tests': ['tp5n']}, 07:48:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:48:05 INFO - 'talos_options': ['--xperf_path', 07:48:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:48:05 INFO - 'tests': ['tp5n']}}, 07:48:05 INFO - 'talos.zip': {'path': '', 07:48:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:48:05 INFO - Running post-action listener: _resource_record_post_action 07:48:05 INFO - [mozharness: 2017-05-24 14:48:05.915050Z] Finished populate-webroot step (success) 07:48:05 INFO - [mozharness: 2017-05-24 14:48:05.915141Z] Running create-virtualenv step. 07:48:05 INFO - Running pre-action listener: _resource_record_pre_action 07:48:05 INFO - Running main action method: create_virtualenv 07:48:05 INFO - Creating virtualenv /builds/slave/test/build/venv 07:48:05 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 07:48:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:48:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:48:06 INFO - Using real prefix '/usr' 07:48:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:48:06 INFO - Installing distribute.............................................................................................................................................................................................done. 07:48:08 INFO - Installing pip.................done. 07:48:08 INFO - Return code: 0 07:48:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:48:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:48:08 INFO - Reading from file tmpfile_stdout 07:48:08 INFO - Output received: 07:48:08 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) 07:48:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:48:08 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')]} 07:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:08 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')]} 07:48:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:08 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 0x277f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1a400>, '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 0x2a1b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1b840>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1495637255.841561-1340262720', '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 07:48:08 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 07:48:08 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 07:48:08 INFO - Using env: {'DISPLAY': ':0', 07:48:08 INFO - 'HOME': '/home/cltbld', 07:48:08 INFO - 'LANG': 'en_US.UTF-8', 07:48:08 INFO - 'LANGUAGE': 'en_US:en', 07:48:08 INFO - 'LOGNAME': 'cltbld', 07:48:08 INFO - 'MAIL': '/var/mail/cltbld', 07:48:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:08 INFO - 'MOZ_NO_REMOTE': '1', 07:48:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:08 INFO - 'NO_EM_RESTART': '1', 07:48:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:08 INFO - 'PWD': '/builds/slave/test', 07:48:08 INFO - 'SHELL': '/bin/bash', 07:48:08 INFO - 'SHLVL': '1', 07:48:08 INFO - 'TERM': 'linux', 07:48:08 INFO - 'TMOUT': '86400', 07:48:08 INFO - 'USER': 'cltbld', 07:48:08 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1495637255.841561-1340262720', 07:48:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:08 INFO - '_': '/tools/buildbot/bin/python'} 07:48:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:08 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 07:48:08 INFO - Cleaning up... 07:48:08 INFO - Return code: 0 07:48:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:48:08 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')]} 07:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:08 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')]} 07:48:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:08 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 0x277f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1a400>, '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 0x2a1b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1b840>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1495637255.841561-1340262720', '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 07:48:08 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 07:48:08 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 07:48:08 INFO - Using env: {'DISPLAY': ':0', 07:48:08 INFO - 'HOME': '/home/cltbld', 07:48:08 INFO - 'LANG': 'en_US.UTF-8', 07:48:08 INFO - 'LANGUAGE': 'en_US:en', 07:48:08 INFO - 'LOGNAME': 'cltbld', 07:48:08 INFO - 'MAIL': '/var/mail/cltbld', 07:48:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:08 INFO - 'MOZ_NO_REMOTE': '1', 07:48:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:08 INFO - 'NO_EM_RESTART': '1', 07:48:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:08 INFO - 'PWD': '/builds/slave/test', 07:48:08 INFO - 'SHELL': '/bin/bash', 07:48:08 INFO - 'SHLVL': '1', 07:48:08 INFO - 'TERM': 'linux', 07:48:08 INFO - 'TMOUT': '86400', 07:48:08 INFO - 'USER': 'cltbld', 07:48:08 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1495637255.841561-1340262720', 07:48:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:08 INFO - '_': '/tools/buildbot/bin/python'} 07:48:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:09 INFO - Downloading/unpacking psutil>=3.1.1 07:48:09 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 07:48:09 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 07:48:09 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 07:48:09 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 07:48:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:48:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:48:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:48:10 INFO - Installing collected packages: psutil 07:48:10 INFO - Running setup.py install for psutil 07:48:10 INFO - building 'psutil._psutil_linux' extension 07:48:10 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 07:48:10 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 07:48:10 INFO - building 'psutil._psutil_posix' extension 07:48:10 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 07:48:10 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 07:48:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:48:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:48:10 INFO - Successfully installed psutil 07:48:10 INFO - Cleaning up... 07:48:10 INFO - Return code: 0 07:48:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07: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')]} 07:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07: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')]} 07:48:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:10 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 0x277f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1a400>, '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 0x2a1b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1b840>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1495637255.841561-1340262720', '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 07:48:10 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 07:48:10 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 07:48:10 INFO - Using env: {'DISPLAY': ':0', 07:48:10 INFO - 'HOME': '/home/cltbld', 07:48:10 INFO - 'LANG': 'en_US.UTF-8', 07:48:10 INFO - 'LANGUAGE': 'en_US:en', 07:48:10 INFO - 'LOGNAME': 'cltbld', 07:48:10 INFO - 'MAIL': '/var/mail/cltbld', 07:48:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:10 INFO - 'MOZ_NO_REMOTE': '1', 07:48:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:10 INFO - 'NO_EM_RESTART': '1', 07:48:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:10 INFO - 'PWD': '/builds/slave/test', 07:48:10 INFO - 'SHELL': '/bin/bash', 07:48:10 INFO - 'SHLVL': '1', 07:48:10 INFO - 'TERM': 'linux', 07:48:10 INFO - 'TMOUT': '86400', 07:48:10 INFO - 'USER': 'cltbld', 07:48:10 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1495637255.841561-1340262720', 07:48:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:10 INFO - '_': '/tools/buildbot/bin/python'} 07:48:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:48:11 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 07:48:11 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 07:48:11 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 07:48:11 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 07:48:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:48:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:48:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:48:12 INFO - Installing collected packages: mozsystemmonitor 07:48:12 INFO - Running setup.py install for mozsystemmonitor 07:48:12 INFO - Successfully installed mozsystemmonitor 07:48:12 INFO - Cleaning up... 07:48:12 INFO - Return code: 0 07:48:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:48:12 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')]} 07:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:12 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')]} 07:48:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:12 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 0x277f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1a400>, '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 0x2a1b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1b840>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1495637255.841561-1340262720', '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 07:48:12 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 07:48:12 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 07:48:12 INFO - Using env: {'DISPLAY': ':0', 07:48:12 INFO - 'HOME': '/home/cltbld', 07:48:12 INFO - 'LANG': 'en_US.UTF-8', 07:48:12 INFO - 'LANGUAGE': 'en_US:en', 07:48:12 INFO - 'LOGNAME': 'cltbld', 07:48:12 INFO - 'MAIL': '/var/mail/cltbld', 07:48:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:12 INFO - 'MOZ_NO_REMOTE': '1', 07:48:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:12 INFO - 'NO_EM_RESTART': '1', 07:48:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:12 INFO - 'PWD': '/builds/slave/test', 07:48:12 INFO - 'SHELL': '/bin/bash', 07:48:12 INFO - 'SHLVL': '1', 07:48:12 INFO - 'TERM': 'linux', 07:48:12 INFO - 'TMOUT': '86400', 07:48:12 INFO - 'USER': 'cltbld', 07:48:12 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1495637255.841561-1340262720', 07:48:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:12 INFO - '_': '/tools/buildbot/bin/python'} 07:48:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:12 INFO - Downloading/unpacking jsonschema==2.5.1 07: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 07: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 07: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 07: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 07:48:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:48:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:48:13 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 07:48:13 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 07:48:13 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 07:48:13 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 07:48:13 INFO - Downloading functools32-3.2.3-2.tar.gz 07:48:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:48:13 INFO - warning: no files found matching '*.txt' 07:48:13 INFO - no previously-included directories found matching 'build' 07:48:13 INFO - no previously-included directories found matching 'dist' 07:48:13 INFO - no previously-included directories found matching '.git*' 07:48:13 INFO - Installing collected packages: jsonschema, functools32 07:48:13 INFO - Running setup.py install for functools32 07:48:14 INFO - warning: no files found matching '*.txt' 07:48:14 INFO - no previously-included directories found matching 'build' 07:48:14 INFO - no previously-included directories found matching 'dist' 07:48:14 INFO - no previously-included directories found matching '.git*' 07:48:14 INFO - Successfully installed jsonschema functools32 07:48:14 INFO - Cleaning up... 07:48:14 INFO - Return code: 0 07:48:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:48:14 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')]} 07:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:14 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')]} 07:48:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:14 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 0x277f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1a400>, '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 0x2a1b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1b840>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1495637255.841561-1340262720', '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 07:48:14 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 07:48:14 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 07:48:14 INFO - Using env: {'DISPLAY': ':0', 07:48:14 INFO - 'HOME': '/home/cltbld', 07:48:14 INFO - 'LANG': 'en_US.UTF-8', 07:48:14 INFO - 'LANGUAGE': 'en_US:en', 07:48:14 INFO - 'LOGNAME': 'cltbld', 07:48:14 INFO - 'MAIL': '/var/mail/cltbld', 07:48:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:14 INFO - 'MOZ_NO_REMOTE': '1', 07:48:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:14 INFO - 'NO_EM_RESTART': '1', 07:48:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:14 INFO - 'PWD': '/builds/slave/test', 07:48:14 INFO - 'SHELL': '/bin/bash', 07:48:14 INFO - 'SHLVL': '1', 07:48:14 INFO - 'TERM': 'linux', 07:48:14 INFO - 'TMOUT': '86400', 07:48:14 INFO - 'USER': 'cltbld', 07:48:14 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1495637255.841561-1340262720', 07:48:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:14 INFO - '_': '/tools/buildbot/bin/python'} 07:48:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:48:14 INFO - Cleaning up... 07:48:14 INFO - Return code: 0 07:48:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:48:14 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')]} 07:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:14 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')]} 07:48:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:14 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 0x277f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1a400>, '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 0x2a1b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1b840>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1495637255.841561-1340262720', '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 07:48:14 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 07:48:14 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 07:48:14 INFO - Using env: {'DISPLAY': ':0', 07:48:14 INFO - 'HOME': '/home/cltbld', 07:48:14 INFO - 'LANG': 'en_US.UTF-8', 07:48:14 INFO - 'LANGUAGE': 'en_US:en', 07:48:14 INFO - 'LOGNAME': 'cltbld', 07:48:14 INFO - 'MAIL': '/var/mail/cltbld', 07:48:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:14 INFO - 'MOZ_NO_REMOTE': '1', 07:48:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:14 INFO - 'NO_EM_RESTART': '1', 07:48:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:14 INFO - 'PWD': '/builds/slave/test', 07:48:14 INFO - 'SHELL': '/bin/bash', 07:48:14 INFO - 'SHLVL': '1', 07:48:14 INFO - 'TERM': 'linux', 07:48:14 INFO - 'TMOUT': '86400', 07:48:14 INFO - 'USER': 'cltbld', 07:48:14 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1495637255.841561-1340262720', 07:48:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:14 INFO - '_': '/tools/buildbot/bin/python'} 07:48:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:14 INFO - Downloading/unpacking blobuploader==1.2.4 07:48:14 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 07:48:14 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 07:48:14 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 07:48:14 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 07:48:15 INFO - Downloading blobuploader-1.2.4.tar.gz 07:48:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:48:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:48:15 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 07:48:15 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 07:48:15 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 07:48:15 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 07:48:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:48:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:48:16 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 07:48:16 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 07:48:16 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 07:48:16 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 07:48:16 INFO - Downloading docopt-0.6.1.tar.gz 07:48:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:48:16 INFO - Installing collected packages: blobuploader, requests, docopt 07:48:16 INFO - Running setup.py install for blobuploader 07:48:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:48:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:48:16 INFO - Running setup.py install for requests 07:48:16 INFO - Running setup.py install for docopt 07:48:16 INFO - Successfully installed blobuploader requests docopt 07:48:16 INFO - Cleaning up... 07:48:16 INFO - Return code: 0 07:48:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:48:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:16 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 0x277f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1a400>, '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 0x2a1b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1b840>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1495637255.841561-1340262720', '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 07:48:16 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 07:48:16 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 07:48:16 INFO - Using env: {'DISPLAY': ':0', 07:48:16 INFO - 'HOME': '/home/cltbld', 07:48:16 INFO - 'LANG': 'en_US.UTF-8', 07:48:16 INFO - 'LANGUAGE': 'en_US:en', 07:48:16 INFO - 'LOGNAME': 'cltbld', 07:48:16 INFO - 'MAIL': '/var/mail/cltbld', 07:48:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:16 INFO - 'MOZ_NO_REMOTE': '1', 07:48:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:16 INFO - 'NO_EM_RESTART': '1', 07:48:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:16 INFO - 'PWD': '/builds/slave/test', 07:48:16 INFO - 'SHELL': '/bin/bash', 07:48:16 INFO - 'SHLVL': '1', 07:48:16 INFO - 'TERM': 'linux', 07:48:16 INFO - 'TMOUT': '86400', 07:48:16 INFO - 'USER': 'cltbld', 07:48:16 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1495637255.841561-1340262720', 07:48:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:16 INFO - '_': '/tools/buildbot/bin/python'} 07:48:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:48:17 INFO - Running setup.py (path:/tmp/pip-DJurny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:48:17 INFO - Running setup.py (path:/tmp/pip-fe1AFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:48:17 INFO - Running setup.py (path:/tmp/pip-xPU7St-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:48:17 INFO - Running setup.py (path:/tmp/pip-o62Kr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:48:17 INFO - Running setup.py (path:/tmp/pip-Jcv4OL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:48:17 INFO - Running setup.py (path:/tmp/pip-vAw3U7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:48:17 INFO - Running setup.py (path:/tmp/pip-5BdYkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:48:17 INFO - Running setup.py (path:/tmp/pip-qYpoWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:48:17 INFO - Running setup.py (path:/tmp/pip-qZ_qLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:48:17 INFO - Running setup.py (path:/tmp/pip-LIgYum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:48:17 INFO - Running setup.py (path:/tmp/pip-2OcW_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:48:17 INFO - Running setup.py (path:/tmp/pip-tIXnLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:48:17 INFO - Running setup.py (path:/tmp/pip-uNELRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:48:18 INFO - Running setup.py (path:/tmp/pip-rIoTuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:48:18 INFO - Running setup.py (path:/tmp/pip-zwLha8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:48:18 INFO - Running setup.py (path:/tmp/pip-C4d606-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:48:18 INFO - Running setup.py (path:/tmp/pip-ipKNkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:48:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:48:18 INFO - Running setup.py install for manifestparser 07:48:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:48:18 INFO - Running setup.py install for mozcrash 07:48:18 INFO - Running setup.py install for mozdebug 07:48:18 INFO - Running setup.py install for mozdevice 07:48:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:48:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:48:18 INFO - Running setup.py install for mozfile 07:48:18 INFO - Running setup.py install for mozhttpd 07:48:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:48:18 INFO - Running setup.py install for mozinfo 07:48:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:48:19 INFO - Running setup.py install for mozInstall 07:48:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:48:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:48:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:48:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:48:19 INFO - Running setup.py install for mozleak 07:48:19 INFO - Running setup.py install for mozlog 07:48:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:48:19 INFO - Running setup.py install for moznetwork 07:48:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:48:19 INFO - Running setup.py install for mozprocess 07:48:19 INFO - Running setup.py install for mozprofile 07:48:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:48:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:48:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:48:19 INFO - Running setup.py install for mozrunner 07:48:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:48:19 INFO - Running setup.py install for mozscreenshot 07:48:19 INFO - Running setup.py install for moztest 07:48:19 INFO - Running setup.py install for mozversion 07:48:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:48:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:48:20 INFO - Cleaning up... 07:48:20 INFO - Return code: 0 07:48:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:48:20 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')]} 07:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:20 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')]} 07:48:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:20 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 0x277f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1a400>, '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 0x2a1b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1b840>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1495637255.841561-1340262720', '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 07:48:20 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 07:48:20 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 07:48:20 INFO - Using env: {'DISPLAY': ':0', 07:48:20 INFO - 'HOME': '/home/cltbld', 07:48:20 INFO - 'LANG': 'en_US.UTF-8', 07:48:20 INFO - 'LANGUAGE': 'en_US:en', 07:48:20 INFO - 'LOGNAME': 'cltbld', 07:48:20 INFO - 'MAIL': '/var/mail/cltbld', 07:48:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:20 INFO - 'MOZ_NO_REMOTE': '1', 07:48:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:20 INFO - 'NO_EM_RESTART': '1', 07:48:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:20 INFO - 'PWD': '/builds/slave/test', 07:48:20 INFO - 'SHELL': '/bin/bash', 07:48:20 INFO - 'SHLVL': '1', 07:48:20 INFO - 'TERM': 'linux', 07:48:20 INFO - 'TMOUT': '86400', 07:48:20 INFO - 'USER': 'cltbld', 07:48:20 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1495637255.841561-1340262720', 07:48:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:20 INFO - '_': '/tools/buildbot/bin/python'} 07:48:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:48:20 INFO - Running setup.py (path:/tmp/pip-og9fum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:48:20 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)) 07:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:48:20 INFO - Running setup.py (path:/tmp/pip-uOepKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:48:20 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)) 07:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:48:20 INFO - Running setup.py (path:/tmp/pip-6DYzEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:48:20 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)) 07:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:48:20 INFO - Running setup.py (path:/tmp/pip-xYMNY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:48:20 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)) 07:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:48:20 INFO - Running setup.py (path:/tmp/pip-uf3yLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:48:20 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)) 07:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:48:20 INFO - Running setup.py (path:/tmp/pip-P2tCFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:48:20 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)) 07:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:48:20 INFO - Running setup.py (path:/tmp/pip-q3gPtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:48:20 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)) 07:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:48:20 INFO - Running setup.py (path:/tmp/pip-bPnvhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:48:20 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)) 07:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:48:20 INFO - Running setup.py (path:/tmp/pip-Hk351L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:48:20 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)) 07:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:48:20 INFO - Running setup.py (path:/tmp/pip-M0PUDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:48:21 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)) 07:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:48:21 INFO - Running setup.py (path:/tmp/pip-88bthp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:48:21 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)) 07:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:48:21 INFO - Running setup.py (path:/tmp/pip-YYZYAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:48:21 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)) 07:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:48:21 INFO - Running setup.py (path:/tmp/pip-dJoBlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:48:21 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)) 07:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:48:21 INFO - Running setup.py (path:/tmp/pip-LimoqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:48:21 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)) 07:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:48:21 INFO - Running setup.py (path:/tmp/pip-o8v1pK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:48:21 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)) 07:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:48:21 INFO - Running setup.py (path:/tmp/pip-jc8jvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:48:21 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)) 07:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:48:21 INFO - Running setup.py (path:/tmp/pip-pMQFld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:48:21 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)) 07:48:21 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)) 07:48:21 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)) 07:48:21 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)) 07:48:21 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)) 07:48:21 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)) 07:48:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:48:21 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 07:48:21 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 07:48:21 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 07:48:21 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 07:48:22 INFO - Downloading blessings-1.6.tar.gz 07:48:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:48:22 INFO - Installing collected packages: blessings 07:48:22 INFO - Running setup.py install for blessings 07:48:22 INFO - Successfully installed blessings 07:48:22 INFO - Cleaning up... 07:48:22 INFO - Return code: 0 07:48:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:48:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:48:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:48:23 INFO - Reading from file tmpfile_stdout 07:48:23 INFO - Current package versions: 07:48:23 INFO - argparse == 1.2.1 07:48:23 INFO - blessings == 1.6 07:48:23 INFO - blobuploader == 1.2.4 07:48:23 INFO - docopt == 0.6.1 07:48:23 INFO - functools32 == 3.2.3-2 07:48:23 INFO - jsonschema == 2.5.1 07:48:23 INFO - manifestparser == 1.1 07:48:23 INFO - mozInstall == 1.12 07:48:23 INFO - mozcrash == 1.0 07:48:23 INFO - mozdebug == 0.1 07:48:23 INFO - mozdevice == 0.49 07:48:23 INFO - mozfile == 1.2 07:48:23 INFO - mozhttpd == 0.7 07:48:23 INFO - mozinfo == 0.9 07:48:23 INFO - mozleak == 0.1 07:48:23 INFO - mozlog == 3.4 07:48:23 INFO - moznetwork == 0.27 07:48:23 INFO - mozprocess == 0.25 07:48:23 INFO - mozprofile == 0.28 07:48:23 INFO - mozrunner == 6.13 07:48:23 INFO - mozscreenshot == 0.1 07:48:23 INFO - mozsystemmonitor == 0.3 07:48:23 INFO - moztest == 0.8 07:48:23 INFO - mozversion == 1.4 07:48:23 INFO - psutil == 3.1.1 07:48:23 INFO - requests == 1.2.3 07:48:23 INFO - wsgiref == 0.1.2 07:48:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:23 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 0x277f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1a400>, '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 0x2a1b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1b840>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1495637255.841561-1340262720', '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 07:48:23 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 07:48:23 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 07:48:23 INFO - Using env: {'DISPLAY': ':0', 07:48:23 INFO - 'HOME': '/home/cltbld', 07:48:23 INFO - 'LANG': 'en_US.UTF-8', 07:48:23 INFO - 'LANGUAGE': 'en_US:en', 07:48:23 INFO - 'LOGNAME': 'cltbld', 07:48:23 INFO - 'MAIL': '/var/mail/cltbld', 07:48:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:23 INFO - 'MOZ_NO_REMOTE': '1', 07:48:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:23 INFO - 'NO_EM_RESTART': '1', 07:48:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:23 INFO - 'PWD': '/builds/slave/test', 07:48:23 INFO - 'SHELL': '/bin/bash', 07:48:23 INFO - 'SHLVL': '1', 07:48:23 INFO - 'TERM': 'linux', 07:48:23 INFO - 'TMOUT': '86400', 07:48:23 INFO - 'USER': 'cltbld', 07:48:23 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1495637255.841561-1340262720', 07:48:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:23 INFO - '_': '/tools/buildbot/bin/python'} 07:48:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:23 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)) 07:48:23 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)) 07:48:23 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)) 07:48:23 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)) 07:48:23 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)) 07:48:23 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)) 07:48:23 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)) 07:48:23 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)) 07:48:23 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)) 07:48:23 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)) 07:48:23 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)) 07:48:23 INFO - Cleaning up... 07:48:23 INFO - Return code: 0 07:48:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x277f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1a400>, '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 0x2a1b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1b840>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1495637255.841561-1340262720', '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 07:48:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:48:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:48:23 INFO - Using env: {'DISPLAY': ':0', 07:48:23 INFO - 'HOME': '/home/cltbld', 07:48:23 INFO - 'LANG': 'en_US.UTF-8', 07:48:23 INFO - 'LANGUAGE': 'en_US:en', 07:48:23 INFO - 'LOGNAME': 'cltbld', 07:48:23 INFO - 'MAIL': '/var/mail/cltbld', 07:48:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:23 INFO - 'MOZ_NO_REMOTE': '1', 07:48:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:23 INFO - 'NO_EM_RESTART': '1', 07:48:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:23 INFO - 'PWD': '/builds/slave/test', 07:48:23 INFO - 'SHELL': '/bin/bash', 07:48:23 INFO - 'SHLVL': '1', 07:48:23 INFO - 'TERM': 'linux', 07:48:23 INFO - 'TMOUT': '86400', 07:48:23 INFO - 'USER': 'cltbld', 07:48:23 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1495637255.841561-1340262720', 07:48:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:23 INFO - '_': '/tools/buildbot/bin/python'} 07:48:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:48:23 INFO - Cleaning up... 07:48:23 INFO - Return code: 0 07:48:23 INFO - Running post-action listener: _resource_record_post_action 07:48:23 INFO - Running post-action listener: _start_resource_monitoring 07:48:23 INFO - Starting resource monitoring. 07:48:23 INFO - [mozharness: 2017-05-24 14:48:23.574061Z] Finished create-virtualenv step (success) 07:48:23 INFO - [mozharness: 2017-05-24 14:48:23.574535Z] Running install step. 07:48:23 INFO - Running pre-action listener: _resource_record_pre_action 07:48:23 INFO - Running main action method: install 07:48:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:48:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:48:23 INFO - Reading from file tmpfile_stdout 07:48:23 INFO - Detecting whether we're running mozinstall >=1.0... 07:48:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:48:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:48:23 INFO - Reading from file tmpfile_stdout 07:48:23 INFO - Output received: 07:48:23 INFO - Usage: mozinstall [options] installer 07:48:23 INFO - Options: 07:48:23 INFO - -h, --help show this help message and exit 07:48:23 INFO - -d DEST, --destination=DEST 07:48:23 INFO - Directory to install application into. [default: 07:48:23 INFO - "/builds/slave/test"] 07:48:23 INFO - --app=APP Application being installed. [default: firefox] 07:48:23 INFO - mkdir: /builds/slave/test/build/application 07:48:23 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'] 07:48:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:48:37 INFO - Reading from file tmpfile_stdout 07:48:37 INFO - Output received: 07:48:37 INFO - /builds/slave/test/build/application/firefox/firefox 07:48:37 INFO - Running post-action listener: _resource_record_post_action 07:48:37 INFO - [mozharness: 2017-05-24 14:48:37.952119Z] Finished install step (success) 07:48:37 INFO - [mozharness: 2017-05-24 14:48:37.952363Z] Running run-tests step. 07:48:37 INFO - Running pre-action listener: _resource_record_pre_action 07:48:37 INFO - Running main action method: run_tests 07:48:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:48:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:48:37 INFO - Python 2.7.3 07:48:37 INFO - Return code: 0 07:48:37 INFO - grabbing minidump binary from tooltool 07:48:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:37 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 0x2a1a400>, '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 0x2a1b3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1b840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:48:37 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 07:48:37 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 07:48:37 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 07:48:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:48:38 INFO - Return code: 0 07:48:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:48:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:48:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:48:38 INFO - ENV: RUST_BACKTRACE is now 1 07:48:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:48:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:48:38 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/Sw4LfCkoRPCFVmByx_5YBQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 07:48:38 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/Sw4LfCkoRPCFVmByx_5YBQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 07:48:38 INFO - Using env: {'DISPLAY': ':0', 07:48:38 INFO - 'HOME': '/home/cltbld', 07:48:38 INFO - 'LANG': 'en_US.UTF-8', 07:48:38 INFO - 'LANGUAGE': 'en_US:en', 07:48:38 INFO - 'LOGNAME': 'cltbld', 07:48:38 INFO - 'MAIL': '/var/mail/cltbld', 07:48:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:48:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:48:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:38 INFO - 'MOZ_NO_REMOTE': '1', 07:48:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:48:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:38 INFO - 'NO_EM_RESTART': '1', 07:48:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:38 INFO - 'PWD': '/builds/slave/test', 07:48:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:48:38 INFO - 'RUST_BACKTRACE': '1', 07:48:38 INFO - 'SHELL': '/bin/bash', 07:48:38 INFO - 'SHLVL': '1', 07:48:38 INFO - 'TERM': 'linux', 07:48:38 INFO - 'TMOUT': '86400', 07:48:38 INFO - 'USER': 'cltbld', 07:48:38 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1495637255.841561-1340262720', 07:48:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:38 INFO - '_': '/tools/buildbot/bin/python'} 07:48:38 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/Sw4LfCkoRPCFVmByx_5YBQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 07:48:38 INFO - mozversion application_buildid: 20170524134711 07:48:38 INFO - mozversion application_changeset: c58deb31c649510a264a7593359da8b910b01141 07:48:38 INFO - mozversion application_display_name: Firefox 07:48:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:48:38 INFO - mozversion application_name: Firefox 07:48:38 INFO - mozversion application_remotingname: firefox 07:48:38 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:48:38 INFO - mozversion application_vendor: Mozilla 07:48:38 INFO - mozversion application_version: 54.0 07:48:38 INFO - mozversion platform_buildid: 20170524134711 07:48:38 INFO - mozversion platform_changeset: c58deb31c649510a264a7593359da8b910b01141 07:48:38 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:48:38 INFO - mozversion platform_version: 54.0 07:48:38 INFO - using testdate: 1495637318 07:48:38 INFO - actual date: 1495637318 07:48:38 INFO - starting webserver on 'localhost:37138' 07:48:38 INFO - SUITE-START | Running 2 tests 07:48:38 INFO - TEST-START | dromaeo_css 07:48:38 INFO - operating with platform_type : linux_ 07:48:38 INFO - Initialising browser for dromaeo_css test... 07:48:38 INFO - TEST-INFO | started process 32143 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP_DoXq/profile http://localhost:37138/getInfo.html) 07:48:42 INFO - PROCESS | 32143 | __metrics Screen width/height:1600/1200 07:48:42 INFO - PROCESS | 32143 | colorDepth:24 07:48:42 INFO - PROCESS | 32143 | Browser inner width/height: 1024/697 07:48:42 INFO - PROCESS | 32143 | __metrics 07:48:43 INFO - PROCESS | 32143 | 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" 07:48:43 INFO - PROCESS | 32143 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:48:43 INFO - TEST-INFO | 32143: exit 0 07:48:43 INFO - Browser initialized. 07:48:43 INFO - Running cycle 1/1 for dromaeo_css test... 07:48:43 INFO - TEST-INFO | started process 32232 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP_DoXq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:48:55 INFO - PROCESS | 32232 | RSS: Main: 141488128 07:48:55 INFO - PROCESS | 32232 | 07:51:57 INFO - PROCESS | 32232 | Cycle 1(1): loaded http://localhost:37138/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37138/tests/dromaeo/cssquery-ext.html) 07:51:58 INFO - PROCESS | 32232 | RSS: Main: 284823552 07:51:58 INFO - PROCESS | 32232 | 07:55:00 INFO - PROCESS | 32232 | Cycle 1(1): loaded http://localhost:37138/tests/dromaeo/cssquery-ext.html (next: http://localhost:37138/tests/dromaeo/cssquery-jquery.html) 07:55:01 INFO - PROCESS | 32232 | RSS: Main: 231047168 07:55:01 INFO - PROCESS | 32232 | 07:58:03 INFO - PROCESS | 32232 | Cycle 1(1): loaded http://localhost:37138/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37138/tests/dromaeo/cssquery-mootools.html) 07:58:03 INFO - PROCESS | 32232 | RSS: Main: 172388352 07:58:03 INFO - PROCESS | 32232 | 08:01:05 INFO - PROCESS | 32232 | Cycle 1(1): loaded http://localhost:37138/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37138/tests/dromaeo/cssquery-prototype.html) 08:01:06 INFO - PROCESS | 32232 | RSS: Main: 172171264 08:01:06 INFO - PROCESS | 32232 | 08:04:09 INFO - PROCESS | 32232 | Cycle 1(1): loaded http://localhost:37138/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37138/tests/dromaeo/cssquery-yui.html) 08:04:09 INFO - PROCESS | 32232 | RSS: Main: 172597248 08:04:09 INFO - PROCESS | 32232 | 08:07:12 INFO - PROCESS | 32232 | Cycle 1(1): loaded http://localhost:37138/tests/dromaeo/cssquery-yui.html (next: http://localhost:37138/tests/dromaeo/cssquery-dojo.html) 08:07:12 INFO - PROCESS | 32232 | RSS: Main: 263172096 08:07:12 INFO - PROCESS | 32232 | 08:07:12 INFO - PROCESS | 32232 | __start_tp_report 08:07:12 INFO - PROCESS | 32232 | _x_x_mozilla_page_load 08:07:12 INFO - PROCESS | 32232 | _x_x_mozilla_page_load_details 08:07:12 INFO - PROCESS | 32232 | |i|pagename|runs| 08:07:12 INFO - PROCESS | 32232 | |0;dojo.html;3312.7184189343902;3375.47680109583;3391.203067279189;3410.4884267359876;3425.297813948141;5812.4768770810615;5871.588988770788;5883.146943693162;5887.85280367991;5891.8821623567555;5880.647161170333;5885.911711324323;5909.143174239733;5927.199828023216;5929.970350148254;5204.609654275935;5222.3472065991755;5235.633505654606;5264.157734762439;5303.867403314929;5112.284280200756;5132.999065182291;5311.681299122046;5321.414644389133;5322.547583455411;5163.793448262065;5195.506426889439;5222.164453687411;5231.293775340338;5239.397469291023;5267.52592266696;5301.6818990860675;5304.522592966613;5307.2039194121;5307.814226502054;5076.36545431821;5176.896462070775;5224.138017227153;5249.8425047248265;5310.7610157543;5766.452187042224;5780.7687692492245;5801.0428279333855;5808.3030036395485;5813.011787996051;6277.591956522857;6288.768773560411;6315.557910946236;6325.430711235965;6327.525435592349;6358.618482890995;6366.331535188831;6370.649614271213;6371.8407039823915;6383.265924418705;5719.48524632785;5755.712214389306;5850.356460789352;5891;5898.4101589840675;6456.838579035561;6458.870822583522;6463.7091330890225;6464.547481676237;6472.967635161888;6178.5366097542865;6231.781887633911;6244.500439964792;6246.531510136758;6247.468965138014;6068.150458935753;6116.113163591254;6172.814815555541;6219.720112594944;6315.968420157962;6234.937650623527;6272.1219029335925;6286.717097730521;6287.1826662534495;6294.685265736694;6053.27360716708;6100.664463454464;6103.664298463627;6263.467605253513;6276.843078923063;4698.835540756126;4746.905061898743;4758.547937945889;4759.4764575896625;4781.450133234653;4161.646260067928;4184.748915065105;4190.832366705297;4233.026403927114;4276.273033584298;5977;5991.071383935497;6019.548533859978;6025.487833534199;6045.425684559959;6312.936870631235;6334.651594162366;6342.39747224013;6360.045993101072;6373.649449280334;5784.2769653793275;5991.191189189491;6000.429959153874;6001.789937352171;6002.129691194752;5278.049951008778;5289.312389389432;5317.1492561190025;5327.147656374961;5329.866753331198;6582.308857569887;6601.438877695354;6632.1709786276715;6636.734530618818;6644.103046088813;6291.276503202191;6313.842153946188;6358.459530939922;6369.777057802955;6373.330800266091;6260.123582698517;6304.275008374096;6508.121403610641;6535.44448721864;6536.7712130075215;6248.812535623939;6248.937510625017;6250.843728906813;6251.499880009679;6254.718537665907;6345.873082538231;6346.048092786119;6346.333634968262;6366.363363663597;6374.58565193261;5982.970085149546;6027.095935609518;6071.180390647382;6122.846928826815;6140.20177376956;6148.723307451086;6158.261008678808;6198;6199.876002480015;6207.410296021871;6181.474574661024;6190.969045154746;6193.792210518905;6195.101710252078;6198.380161983766;5982.042873140451;5994.940050599613;6053.939460605514;6116.092308610808;6127.169935487709;6041.2750469943885;6046.818595442144;6062.120992456157;6083.148359229623;6103.542234332354 08:07:12 INFO - PROCESS | 32232 | |1;ext.html;753.476333947906;839.91600839916;855.9400841941065;907.0294784580501;915.2266334946968;31304;43340.56659433405;44272.55727442729;44323.556764432346;44343.556564434344;42231.366529502004;42470.57529424705;42522.36216456748;46610;46715;7501.887471687929;9118.589663465127;9256;9256.768580785467;9266.860997085048;7592.734254301101;10629.84055239172;10831.67504974848;10832.67501974942;10841.403722795243;10994.450277486134;11023.118150547976;11027.72430689231;11030.613928512505;11038.337699738042;10897.182711296606;10943.28868623541;10960.12319014477;10977.1218302536;10978.890211097867;10837;10909.07272881798;10914.56341746337;10916.617918372818;10918.399488028155;43048.78475607633;43056.569434305566;43250.351244731355;43254.35118473225;43280;4266.57334266574;4305.244643428208;4312.460942382202;4420.226460369455;4460.442444694413;30650;31461.37077258442;31669.20826979321;32288.838555807306;32633.83683081593;4388.188185185751;4389.498264813825;4439.445069366329;4445.955540444619;4607.585317321457;236891;238905;239041;239809;240074;54518.45481545213;54551.45448545543;54619.45380546223;54743.72628136834;54748.178777318375;56983;57281.14078288746;57301.42698572961;57400;57433;17138;17287.74068388975;17399;17402.564935876704;17413.12934353277;12532.624021279376;12709.872901270868;15185.924070379577;15250.389984400499;15272;13864;14268.500602478864;14679.045862018935;14704.41182352694;14829;5728.79949201776;5740.311162660508;5755.6977209116685;5788.88422231553;5863.856547973104;1000.9349392289478;1002.2583288366702;1003.8343673293971;1018.1244130048152;1031.850381694665;28588.714112859023;28728.71271287302;28777;29128.271793204916;29310.12069637914;1082.626493859617;1087.6247694545368;1099.263493459384;1116.0736588631416;1122.8764835868049;15117.773233401507;15386.461473848585;15393.538193854203;15631.921840390953;15757.290921908541;310335;310506;311046;311550;311686;54560.454395455534;54619.45380546144;54706.726466367414;54783;54973.45026549763;1460.9634759131106;1476.9556913292618;1496.2743069611229;1543.8764898808067;1547.9938040273687;27828;28687.42625147527;29120.417591647623;29351.119466416043;29474.115776526738;37376.252474949804;37629.247415052094;37651;37670.8116459416;37689;286404;288225;288231;288986;289536;24661.87669061643;26914.461710765285;29052.709472905;30379.08862734033;30678.386432271676;37411.812940935124;37628.435573466966;37880.81059594794;39033.8048309768;39057.41413878851;29548.409031818814;29953.550696740003;30070.84964575163;30351.848240759537;30736.538951916187;29651.88655191174;29705;29744;29885.252868678457;29920.25199370033;33492.832535837166;33977;34164;34329.65670343264;34433.13917152091;28622.85688571544;28941.421171576872;29261.122166335044;29269.560956585243;29599.85200073986;23156.536869262858;23376.76623233746;23412.297631071095;23511.647325289792;23882.880585596962 08:07:12 INFO - PROCESS | 32232 | |2;jquery.html;445.2586443571454;449.8987727761253;468.3069057794464;470.6235011990407;477.1959248665998;19487.707684384746;21248.7431933342;22175;22387.32838014862;22650.77349226507;20592.588148237064;21058.368248952516;22153.778462215374;22689.773102269013;22838.08647654096;6658.267590565034;6717.966410167943;6780.1524809398825;6853.0748348973;6896.379325860671;6747.291534388867;6776.119104516406;6820.874555698304;6823.488238382116;6825.897611535806;7262.818429539251;7539.170691223961;7571.810704732398;7573.848523029536;7579.052618422697;7540.547567145989;7649.655765490538;7662.310392064741;7674.53952762836;7701.653425595806;7289.38040266578;7469.365103966115;7473.3274005339235;7475.327220550176;7537.0955485341565;24701;24903.128390506245;25051.24846254615;25079.49841003188;25294.87352563244;3188.3623275344794;3216.533602627606;3329.0678609989;3556.5554305711785;3744.756590821588;14901.180435076067;15509.302081406364;15729.213539323102;15907.284172212278;15916.283767230387;2263.9320820375415;2345.5074434368803;2350.659154422599;2385.4513461903857;2391.318474234852;115544;119102;119159;119377.99999999913;120240;18594.442166735018;18736.250549978122;18856.528586785167;18942.537470128795;19043.333483328017;32038.757286990152;32119.357612847612;32198.19504512406;32260;32312;10243.59025638981;10259.9487002566;10346.586136554604;10715.303505272132;10728.946355268174;8751.737447876574;8860.291176705849;8901.866472002925;8921.464712117293;9105.135012173832;9298.209652179641;9352.298577606707;9383.812323753487;9652.613895444245;9668.323217374857;3222.436073687142;3652.2695460907926;3821.8849840255925;3876.5154355705536;3965.4250133730447;980.2648013989508;980.7057882635323;981.474910922653;988.7083310423442;1019.5259204469957;20981.475463113544;21134;21207.469813254793;21251.61864478804;21345.14619415206;993.5876611206269;998.8751406074241;1005.6982905128432;1010.4139599032543;1021.1371391174446;11416.42917854104;11487.368194749202;11836.349000805038;11847.76304473923;11855.76288474243;690850;778548;781841;795951;812888;115053.4247328758;122117;125961;126786;127339;1351.9932400337934;1388.2156581531403;1431.3773508523618;1435.3612642374044;1442.4951267056447;18759.71860422122;19247.422577322704;19268.4219473416;19384.321548745727;19540.804591954467;38299.23401532009;47808.760956194994;51237.71905702238;52783.94432111413;55054.44945550493;71498.64250678921;72689.27310726825;72779.27220727937;73040.26959730334;73208.63395683201;12687.555935542212;13054.934725326313;13058.869411306145;13166.934165329112;13201;13843.930780346034;13960.930195348958;14017.649558761113;14215;14619.780703289247;12036.879631203576;12092.576759813364;12188.51245950152;12252.142350035769;12326.630201093982;11668.241564298294;11737.061035117;11796.056315494912;11900.702482438008;12024.158308918291;11876;12109.273443593413;12322.507099715911;12427.067969902113;12574.49702011946;12283.508659653871;12396;12442.688932776753;12553.811692824798;12695.492180312684;11994.76010479803;12012.63962081139;12057.81913271284;12098.576549820715;12273 08:07:12 INFO - PROCESS | 32232 | |3;mootools.html;1555.7044161609294;1565.9843401565981;1572.90562566246;1576.5270418874334;1583.9841601583987;11201.327920324786;11964.34196119213;11971.880281197185;11985.041196704264;11994.58018969334;11338.263012904175;11650.067994560435;11680;11999.460024298905;12034.09744269179;2520.4833009233107;2548.439343344461;2551.1963731424635;2551.6427700122;2554.7828434583084;2410.843295185807;2435.3181109289426;2466.260121963413;2473.826832121752;2473.9134130305442;2415.830891837572;2436.463977924863;2447.449323902126;2450.424150324672;2451;2346.425125844162;2347.9882600587057;2361.421451744325;2367.9052837886466;2393.1504315967927;2356.2695564374926;2369.076060336453;2376.988115059431;2379.369467091205;2379.916702915407;11730.17888747788;11929.522819087226;11937.880621193764;11958.40207989597;11958.940205298917;6034.0948857671265;6155.599886007395;6177.598456100339;6185.288691800455;6187.907181392283;3592.5329707137903;3614.855405783792;3683.1344634010984;3715.8327875245677;3718.3121122592406;1325.6345963657352;1328.4154971812372;1346.3470216944775;1358.9796153057712;1418.7446259673254;17952.730709039373;17971.640567188584;18109.275628974694;18168.727469087975;18242.543936401562;4763.356946812205;4786.841354056937;4865.440474345425;4944.233643785219;5043.87390315245;13496.39266233022;13508.662283442993;13528;13558.525451609343;13618.250996195304;6143.232095988002;6159.630422174684;6166.969165154145;6167.259928808482;6168.290646575611;5528.668279903219;5553.083741182741;5606.6636001840025;5629.211910332557;5636.18275350072;4079.755674519241;4127.731697439657;4170.218280968821;4195.853145139967;4213.052063285736;1061.0503599278757;1063.3566692151292;1069.6042464288264;1085.3108276244484;1086.2396322574073;888.1961824548794;920.6455514626917;950.8240975419569;955.245356168619;1107.9113670906308;7334.046573945459;7532.17146113927;7545.283198096172;7559;7633.274838890296;1146.7018575170516;1157.3345326437332;1159.1654009113424;1173.5481839491686;1177.988220117788;5050.9494905051215;5064.265681476165;5066.620003499752;5114.565261952701;5200.947990520122;14090.436382544789;14712.117272963442;14797.482088126864;15337.386504539916;15386.538403847902;12887.35563221854;15049.699006020037;15067.547973560811;15073.170975596448;15086.849131508763;9290.210332121846;10296.433696146783;10352.378857268588;10494.947525262478;10600.575976960989;7446.255374462727;7508.812279693051;7708.113566939874;7732.652030658746;7764.767056988299;12658.493660253855;13151.473941042252;13177.27524986135;13294.667633309246;13725.245111518961;13590.116642418212;13596.59210223695;13633;13747.518836841062;13786;9989.300748947504;10237.078662920372;10283.588656453658;10286;10306.072453479223;11001.669949901516;11006.174536909604;11081.889181108409;11177.273477223955;11217.71955701114;9350.766230844283;9401.905980940102;9441.716748497556;9525.285603579898;9790.461524616214;9419;9546.379485333431;9592.376495527767;9649.614015439585;9727.270454716067;8357.749267521984;8378.53918034514;8467.618957147066;8487.91512084896;8588.484690918314;6217.240384711063;6345.524085693683;6365.681715914278;6471.579347342407;6479.967600161969;6914.654267286515;6963.268856770169;7097.396721278749;7102.218755936739;7225.277472252943 08:07:12 INFO - PROCESS | 32232 | |4;prototype.html;412.6265729514789;414.5191577769788;416.716632689771;424.45245633133277;435.9934600980985;5309.0709125903;5348.973255133724;5358.249845021695;5364.704941228231;5375.790447149399;5102.77037533311;5105.243168688913;5293.9735301323435;5296.364436267643;5325.337331334333;4213.705040647156;4216.97891510542;4220.514640816307;4236.343366778139;4244.80898359573;4244.575542445747;4252.425922500469;4267.551907049761;4283.164782867342;4304.827806887721;4234.428352172464;4309.612134907858;4391.780410979454;4395.406620106292;4456.754878481682;4396.054643388937;4402.581754733295;4409.228385032607;4415.558444155591;4420.1380730757355;4128.091819799639;4143.958560414418;4149.771762553059;4167.729097608676;4185.6232939035635;4973.2291494818;5144.794208231666;5193.246979188034;5287.365516138088;5325.547328477084;5160.922586161173;5165.502004418714;5171.4052883918075;5187.610929180289;5196.8960620787375;5577.597665424088;5587.636803607793;5633.32400111985;5685.374608793029;5686.118651609007;4434.246178149722;4633.374494443241;4659.930101048487;4665.86002419928;4695.366125573072;5508.779648814083;5564.387917329131;5771.855703607402;5810.588605728618;5821.50517206038;4715.056988602293;4772.212584923449;4780.856574302777;4784.378030856036;4791.652090475642;4604.700694454917;4718.197906355927;4838.927416088762;4868.3427737255015;4869.220924652039;5033.245013248042;5146.768395422215;5146.845594632167;5166.173412254021;5182.714950677673;5579.637323573955;5597;5599;5601.7396085880355;5619.904118696815;1618.627715625389;1655.188957410884;1656.6521030583713;1678.8321167883357;1686.6205103851535;1271.3134907150036;1277.4506962006426;1315.6579289384638;1321.2931081871152;1324.364305133522;5481.75332110056;5495.175723641486;5499.780008799683;5512.200730893998;5555.805546805923;5789.768409263583;5793.478586927113;5798;5800.709964501758;5805.332386775491;5306.416294207634;5397.892042159135;5450.809221677222;5453.4273901240595;5456.972715136399;2995.4907665696883;3015.130619016224;3022.8790848366257;3025.4705426550704;3025.788194826341;5819.592628515963;5949.196858424058;5989.490893274034;6004.399560044048;6009.669468179292;5762.337331206881;5812.854678632983;5820.941790582125;5886.3230728465915;5907.763689452459;5947.464728174485;5957.510622344414;5979.9402005980255;6026.323942395048;6034.818955431344;5320.866978325418;5636.549076073822;5688.260526131577;5691.601587888974;5736.512396446349;5420.457954204548;5462.945370546244;5482.53286021284;5613.435468477628;5640;5862.970685146547;5899.734511946886;5933.753911678596;5947.256592925884;6045.335013148462;4641.769930968228;4820.783064762024;4826.841558025978;4832.975835120802;4835.226363781919;5738.799142030009;5743.4256574342235;5750.9424905752085;5789.710514474175;5834.970825145847;5597.748101335531;5600.991821472174;5625.381208067028;5681.289838770153;5685;5288.250109942731;5505.9724701376235;5545.279113715191;5592.5525957922455;5606.327240731139;5549.389567147691;5554.611177217556;5574.16387541872;5584.385717570983;5585.3297604287745;5605.299337582802;5607.579431542569;5639.689817060101;5641.830745077655;5657.038303488499;5251.842444726664;5496.862578435571;5502.669839809624;5505.339359276913;5525.171224316385 08:07:12 INFO - PROCESS | 32232 | |5;yui.html;857.734102428247;886.4946980221273;911.8723378726979;931.1386967055472;935.1116439382592;16649;16678.33286668532;16934.98390096595;17464.476065718016;18936.147873345697;17159;17369.652606947853;17601.55996100098;18019;18256;895.3061377432509;900.2617853360231;917.7522069041355;929.5584597316288;937.4047479850276;906.9637214511412;909.1090731083542;910.7495438754329;910.8770316007353;911.4166933162782;969.9903000970006;972.4651441707068;973.8441849304113;975.2588033094863;975.2929126383386;956.7321150077989;957.5164541906362;960.6973803251954;961.9374740641836;962.0523784072718;710.836507603249;710.9537880037781;712.2165617820408;712.8360477090247;712.8538649576824;18083.72874406885;18113.36603218881;18395.816041839546;19219.231230750753;19439.708404373945;15963.521094367188;16300.592485187964;16346.918265408716;16354.509364719077;16691.66616667672;13766.449342026306;14021.719565608733;14127.576172714835;14203.715925681428;14314.856851431456;3866.323393406171;3931.8230679619487;3935.429362742415;3976.5426975897853;4081.918361632751;52220;55947.16079258774;74259.62870185614;81382;88597.55701221517;12725.872741272655;13062;13181.406836692371;13190.340482975813;13191.40638671243;23470.413239669146;23609.05563777464;23636.645450317916;23713.7628623715;23880.88059559691;9018.425060471222;9264.629414823467;9279.072092790668;9303.488308142982;9434.292428067785;5082.872928176826;5123.487651234921;5143.151380022329;5153.407358153785;5225.529702326809;3872.593377695358;3970.940435893464;3971.6624086952356;3975.4434379186937;3975.5030621172355;647.7150053976329;657.7763560389491;660.1550015979553;663.4095654867172;665.8335416145964;808.7735434078468;852.2074470742145;869.7173418638841;880.6081293824187;904.2856143646577;11058.612948546763;11935.283882966876;11985.880141198477;12374.257544547356;12457;710.1229980973494;715.1061173533084;729.8795698709654;734.3867870328336;739.7078154129197;4761.190597598416;4993.550580447777;4997.825076122318;5041.092603331363;5043.117454445457;83015.58492207501;84425.57787211024;86548;87433.56283218543;89003;44864.55135448604;47476.28785568219;60674.69662651658;61330;76896;59673.70163149243;60534.39465605376;60671;60711.08933366003;62096.68951655303;10737.302075365076;11064.114870810477;11282.492287846902;11382.14633902444;11398.145139114433;41487;42675.57324426716;43068;43878.561214387446;44552.33171502495;51058.74470627623;51100.233496498324;51107.488925111764;52790.73604631952;53604.73197633987;13540.72918541604;13651.249181294726;13736.500651735385;14034.508792192224;14187.574372768833;13989.23059231752;15454.227288635748;15750.9212453937;15858.365665373256;16040.117793521002;14677.266136693337;14682.41270349174;14800.851991479947;14854.331555080264;14885.330160143036;15468.303926323568;15538.378464861731;15550.300236489611;15588.766168507254;16406.507804765875;15346.386144554539;15483.071015739091;15524.456644017406;15846.524604261891;16290.918545407198;10446.42544660051;10498.64348377129;10865.945670271598;11047.72380690489;11070.169737269576;11256.606018789631;11335.433228338385;11662.475188616701;11667.183297169116;11701.06391488696 08:07:12 INFO - PROCESS | 32232 | __end_tp_report 08:07:12 INFO - PROCESS | 32232 | __start_cc_report 08:07:12 INFO - PROCESS | 32232 | _x_x_mozilla_cycle_collect,1486 08:07:12 INFO - PROCESS | 32232 | __end_cc_report 08:07:12 INFO - PROCESS | 32232 | __startTimestamp1495638432606__endTimestamp 08:07:12 INFO - PROCESS | 32232 | 08:07:12 INFO - PROCESS | 32232 | ------- Summary: start ------- 08:07:12 INFO - PROCESS | 32232 | Number of tests: 6 08:07:12 INFO - PROCESS | 32232 | 08:07:12 INFO - PROCESS | 32232 | [#0] dojo.html Cycles:165 Average:5821.29 Median:6053.94 stddev:694.54 (11.5%) stddev-sans-first:668.21 08:07:12 INFO - PROCESS | 32232 | Values: 3312.7 3375.5 3391.2 3410.5 3425.3 5812.5 5871.6 5883.1 5887.9 5891.9 5880.6 5885.9 5909.1 5927.2 5930.0 5204.6 5222.3 5235.6 5264.2 5303.9 5112.3 5133.0 5311.7 5321.4 5322.5 5163.8 5195.5 5222.2 5231.3 5239.4 5267.5 5301.7 5304.5 5307.2 5307.8 5076.4 5176.9 5224.1 5249.8 5310.8 5766.5 5780.8 5801.0 5808.3 5813.0 6277.6 6288.8 6315.6 6325.4 6327.5 6358.6 6366.3 6370.6 6371.8 6383.3 5719.5 5755.7 5850.4 5891.0 5898.4 6456.8 6458.9 6463.7 6464.5 6473.0 6178.5 6231.8 6244.5 6246.5 6247.5 6068.2 6116.1 6172.8 6219.7 6316.0 6234.9 6272.1 6286.7 6287.2 6294.7 6053.3 6100.7 6103.7 6263.5 6276.8 4698.8 4746.9 4758.5 4759.5 4781.5 4161.6 4184.7 4190.8 4233.0 4276.3 5977.0 5991.1 6019.5 6025.5 6045.4 6312.9 6334.7 6342.4 6360.0 6373.6 5784.3 5991.2 6000.4 6001.8 6002.1 5278.0 5289.3 5317.1 5327.1 5329.9 6582.3 6601.4 6632.2 6636.7 6644.1 6291.3 6313.8 6358.5 6369.8 6373.3 6260.1 6304.3 6508.1 6535.4 6536.8 6248.8 6248.9 6250.8 6251.5 6254.7 6345.9 6346.0 6346.3 6366.4 6374.6 5983.0 6027.1 6071.2 6122.8 6140.2 6148.7 6158.3 6198.0 6199.9 6207.4 6181.5 6191.0 6193.8 6195.1 6198.4 5982.0 5994.9 6053.9 6116.1 6127.2 6041.3 6046.8 6062.1 6083.1 6103.5 08:07:12 INFO - PROCESS | 32232 | 08:07:12 INFO - PROCESS | 32232 | [#1] ext.html Cycles:180 Average:44621.54 Median:29814.63 stddev:73304.63 (245.9%) stddev-sans-first:73436.27 08:07:12 INFO - PROCESS | 32232 | Values: 753.5 839.9 855.9 907.0 915.2 31304.0 43340.6 44272.6 44323.6 44343.6 42231.4 42470.6 42522.4 46610.0 46715.0 7501.9 9118.6 9256.0 9256.8 9266.9 7592.7 10629.8 10831.7 10832.7 10841.4 10994.5 11023.1 11027.7 11030.6 11038.3 10897.2 10943.3 10960.1 10977.1 10978.9 10837.0 10909.1 10914.6 10916.6 10918.4 43048.8 43056.6 43250.4 43254.4 43280.0 4266.6 4305.2 4312.5 4420.2 4460.4 30650.0 31461.4 31669.2 32288.8 32633.8 4388.2 4389.5 4439.4 4446.0 4607.6 236891.0 238905.0 239041.0 239809.0 240074.0 54518.5 54551.5 54619.5 54743.7 54748.2 56983.0 57281.1 57301.4 57400.0 57433.0 17138.0 17287.7 17399.0 17402.6 17413.1 12532.6 12709.9 15185.9 15250.4 15272.0 13864.0 14268.5 14679.0 14704.4 14829.0 5728.8 5740.3 5755.7 5788.9 5863.9 1000.9 1002.3 1003.8 1018.1 1031.9 28588.7 28728.7 28777.0 29128.3 29310.1 1082.6 1087.6 1099.3 1116.1 1122.9 15117.8 15386.5 15393.5 15631.9 15757.3 310335.0 310506.0 311046.0 311550.0 311686.0 54560.5 54619.5 54706.7 54783.0 54973.5 1461.0 1477.0 1496.3 1543.9 1548.0 27828.0 28687.4 29120.4 29351.1 29474.1 37376.3 37629.2 37651.0 37670.8 37689.0 286404.0 288225.0 288231.0 288986.0 289536.0 24661.9 26914.5 29052.7 30379.1 30678.4 37411.8 37628.4 37880.8 39033.8 39057.4 29548.4 29953.6 30070.8 30351.8 30736.5 29651.9 29705.0 29744.0 29885.3 29920.3 33492.8 33977.0 34164.0 34329.7 34433.1 28622.9 28941.4 29261.1 29269.6 29599.9 23156.5 23376.8 23412.3 23511.6 23882.9 08:07:12 INFO - PROCESS | 32232 | 08:07:12 INFO - PROCESS | 32232 | [#2] jquery.html Cycles:180 Average:41371.15 Median:12325.63 stddev:127184.76 (1031.9%) stddev-sans-first:127504.42 08:07:12 INFO - PROCESS | 32232 | Values: 445.3 449.9 468.3 470.6 477.2 19487.7 21248.7 22175.0 22387.3 22650.8 20592.6 21058.4 22153.8 22689.8 22838.1 6658.3 6718.0 6780.2 6853.1 6896.4 6747.3 6776.1 6820.9 6823.5 6825.9 7262.8 7539.2 7571.8 7573.8 7579.1 7540.5 7649.7 7662.3 7674.5 7701.7 7289.4 7469.4 7473.3 7475.3 7537.1 24701.0 24903.1 25051.2 25079.5 25294.9 3188.4 3216.5 3329.1 3556.6 3744.8 14901.2 15509.3 15729.2 15907.3 15916.3 2263.9 2345.5 2350.7 2385.5 2391.3 115544.0 119102.0 119159.0 119378.0 120240.0 18594.4 18736.3 18856.5 18942.5 19043.3 32038.8 32119.4 32198.2 32260.0 32312.0 10243.6 10259.9 10346.6 10715.3 10728.9 8751.7 8860.3 8901.9 8921.5 9105.1 9298.2 9352.3 9383.8 9652.6 9668.3 3222.4 3652.3 3821.9 3876.5 3965.4 980.3 980.7 981.5 988.7 1019.5 20981.5 21134.0 21207.5 21251.6 21345.1 993.6 998.9 1005.7 1010.4 1021.1 11416.4 11487.4 11836.3 11847.8 11855.8 690850.0 778548.0 781841.0 795951.0 812888.0 115053.4 122117.0 125961.0 126786.0 127339.0 1352.0 1388.2 1431.4 1435.4 1442.5 18759.7 19247.4 19268.4 19384.3 19540.8 38299.2 47808.8 51237.7 52783.9 55054.4 71498.6 72689.3 72779.3 73040.3 73208.6 12687.6 13054.9 13058.9 13166.9 13201.0 13843.9 13960.9 14017.6 14215.0 14619.8 12036.9 12092.6 12188.5 12252.1 12326.6 11668.2 11737.1 11796.1 11900.7 12024.2 11876.0 12109.3 12322.5 12427.1 12574.5 12283.5 12396.0 12442.7 12553.8 12695.5 11994.8 12012.6 12057.8 12098.6 12273.0 08:07:12 INFO - PROCESS | 32232 | 08:07:12 INFO - PROCESS | 32232 | [#3] mootools.html Cycles:180 Average:7364.70 Median:2425.57 stddev:4700.44 (193.8%) stddev-sans-first:4693.36 08:07:12 INFO - PROCESS | 32232 | Values: 1555.7 1566.0 1572.9 1576.5 1584.0 11201.3 11964.3 11971.9 11985.0 11994.6 11338.3 11650.1 11680.0 11999.5 12034.1 2520.5 2548.4 2551.2 2551.6 2554.8 2410.8 2435.3 2466.3 2473.8 2473.9 2415.8 2436.5 2447.4 2450.4 2451.0 2346.4 2348.0 2361.4 2367.9 2393.2 2356.3 2369.1 2377.0 2379.4 2379.9 11730.2 11929.5 11937.9 11958.4 11958.9 6034.1 6155.6 6177.6 6185.3 6187.9 3592.5 3614.9 3683.1 3715.8 3718.3 1325.6 1328.4 1346.3 1359.0 1418.7 17952.7 17971.6 18109.3 18168.7 18242.5 4763.4 4786.8 4865.4 4944.2 5043.9 13496.4 13508.7 13528.0 13558.5 13618.3 6143.2 6159.6 6167.0 6167.3 6168.3 5528.7 5553.1 5606.7 5629.2 5636.2 4079.8 4127.7 4170.2 4195.9 4213.1 1061.1 1063.4 1069.6 1085.3 1086.2 888.2 920.6 950.8 955.2 1107.9 7334.0 7532.2 7545.3 7559.0 7633.3 1146.7 1157.3 1159.2 1173.5 1178.0 5050.9 5064.3 5066.6 5114.6 5200.9 14090.4 14712.1 14797.5 15337.4 15386.5 12887.4 15049.7 15067.5 15073.2 15086.8 9290.2 10296.4 10352.4 10494.9 10600.6 7446.3 7508.8 7708.1 7732.7 7764.8 12658.5 13151.5 13177.3 13294.7 13725.2 13590.1 13596.6 13633.0 13747.5 13786.0 9989.3 10237.1 10283.6 10286.0 10306.1 11001.7 11006.2 11081.9 11177.3 11217.7 9350.8 9401.9 9441.7 9525.3 9790.5 9419.0 9546.4 9592.4 9649.6 9727.3 8357.7 8378.5 8467.6 8487.9 8588.5 6217.2 6345.5 6365.7 6471.6 6480.0 6914.7 6963.3 7097.4 7102.2 7225.3 08:07:12 INFO - PROCESS | 32232 | 08:07:12 INFO - PROCESS | 32232 | [#4] prototype.html Cycles:180 Average:4859.11 Median:5353.61 stddev:1304.91 (24.4%) stddev-sans-first:1265.17 08:07:12 INFO - PROCESS | 32232 | Values: 412.6 414.5 416.7 424.5 436.0 5309.1 5349.0 5358.2 5364.7 5375.8 5102.8 5105.2 5294.0 5296.4 5325.3 4213.7 4217.0 4220.5 4236.3 4244.8 4244.6 4252.4 4267.6 4283.2 4304.8 4234.4 4309.6 4391.8 4395.4 4456.8 4396.1 4402.6 4409.2 4415.6 4420.1 4128.1 4144.0 4149.8 4167.7 4185.6 4973.2 5144.8 5193.2 5287.4 5325.5 5160.9 5165.5 5171.4 5187.6 5196.9 5577.6 5587.6 5633.3 5685.4 5686.1 4434.2 4633.4 4659.9 4665.9 4695.4 5508.8 5564.4 5771.9 5810.6 5821.5 4715.1 4772.2 4780.9 4784.4 4791.7 4604.7 4718.2 4838.9 4868.3 4869.2 5033.2 5146.8 5146.8 5166.2 5182.7 5579.6 5597.0 5599.0 5601.7 5619.9 1618.6 1655.2 1656.7 1678.8 1686.6 1271.3 1277.5 1315.7 1321.3 1324.4 5481.8 5495.2 5499.8 5512.2 5555.8 5789.8 5793.5 5798.0 5800.7 5805.3 5306.4 5397.9 5450.8 5453.4 5457.0 2995.5 3015.1 3022.9 3025.5 3025.8 5819.6 5949.2 5989.5 6004.4 6009.7 5762.3 5812.9 5820.9 5886.3 5907.8 5947.5 5957.5 5979.9 6026.3 6034.8 5320.9 5636.5 5688.3 5691.6 5736.5 5420.5 5462.9 5482.5 5613.4 5640.0 5863.0 5899.7 5933.8 5947.3 6045.3 4641.8 4820.8 4826.8 4833.0 4835.2 5738.8 5743.4 5750.9 5789.7 5835.0 5597.7 5601.0 5625.4 5681.3 5685.0 5288.3 5506.0 5545.3 5592.6 5606.3 5549.4 5554.6 5574.2 5584.4 5585.3 5605.3 5607.6 5639.7 5641.8 5657.0 5251.8 5496.9 5502.7 5505.3 5525.2 08:07:12 INFO - PROCESS | 32232 | 08:07:12 INFO - PROCESS | 32232 | [#5] yui.html Cycles:180 Average:17978.40 Median:42081.29 stddev:21607.02 (51.3%) stddev-sans-first:21629.39 08:07:12 INFO - PROCESS | 32232 | Values: 857.7 886.5 911.9 931.1 935.1 16649.0 16678.3 16935.0 17464.5 18936.1 17159.0 17369.7 17601.6 18019.0 18256.0 895.3 900.3 917.8 929.6 937.4 907.0 909.1 910.7 910.9 911.4 970.0 972.5 973.8 975.3 975.3 956.7 957.5 960.7 961.9 962.1 710.8 711.0 712.2 712.8 712.9 18083.7 18113.4 18395.8 19219.2 19439.7 15963.5 16300.6 16346.9 16354.5 16691.7 13766.4 14021.7 14127.6 14203.7 14314.9 3866.3 3931.8 3935.4 3976.5 4081.9 52220.0 55947.2 74259.6 81382.0 88597.6 12725.9 13062.0 13181.4 13190.3 13191.4 23470.4 23609.1 23636.6 23713.8 23880.9 9018.4 9264.6 9279.1 9303.5 9434.3 5082.9 5123.5 5143.2 5153.4 5225.5 3872.6 3970.9 3971.7 3975.4 3975.5 647.7 657.8 660.2 663.4 665.8 808.8 852.2 869.7 880.6 904.3 11058.6 11935.3 11985.9 12374.3 12457.0 710.1 715.1 729.9 734.4 739.7 4761.2 4993.6 4997.8 5041.1 5043.1 83015.6 84425.6 86548.0 87433.6 89003.0 44864.6 47476.3 60674.7 61330.0 76896.0 59673.7 60534.4 60671.0 60711.1 62096.7 10737.3 11064.1 11282.5 11382.1 11398.1 41487.0 42675.6 43068.0 43878.6 44552.3 51058.7 51100.2 51107.5 52790.7 53604.7 13540.7 13651.2 13736.5 14034.5 14187.6 13989.2 15454.2 15750.9 15858.4 16040.1 14677.3 14682.4 14800.9 14854.3 14885.3 15468.3 15538.4 15550.3 15588.8 16406.5 15346.4 15483.1 15524.5 15846.5 16290.9 10446.4 10498.6 10865.9 11047.7 11070.2 11256.6 11335.4 11662.5 11667.2 11701.1 08:07:12 INFO - PROCESS | 32232 | -------- Summary: end -------- 08:07:12 INFO - PROCESS | 32232 | 08:07:13 INFO - TEST-INFO | 32232: exit 0 08:07:13 INFO - TEST-OK | dromaeo_css | took 1115104ms 08:07:13 INFO - TEST-START | kraken 08:07:13 INFO - operating with platform_type : linux_ 08:07:13 INFO - Initialising browser for kraken test... 08:07:13 INFO - TEST-INFO | started process 32536 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7sKwS1/profile http://localhost:37138/getInfo.html) 08:07:16 INFO - PROCESS | 32536 | __metrics Screen width/height:1600/1200 08:07:16 INFO - PROCESS | 32536 | colorDepth:24 08:07:16 INFO - PROCESS | 32536 | Browser inner width/height: 1024/697 08:07:16 INFO - PROCESS | 32536 | __metrics 08:07:17 INFO - PROCESS | 32536 | 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" 08:07:17 INFO - PROCESS | 32536 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:07:18 INFO - TEST-INFO | 32536: exit 0 08:07:18 INFO - Browser initialized. 08:07:18 INFO - Running cycle 1/1 for kraken test... 08:07:18 INFO - TEST-INFO | started process 32631 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7sKwS1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:07:30 INFO - PROCESS | 32631 | RSS: Main: 141893632 08:07:30 INFO - PROCESS | 32631 | 08:07:32 INFO - PROCESS | 32631 | Cycle 1(1): loaded http://localhost:37138/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37138/tests/kraken/driver.html?testName=audio-beat-detection) 08:07:33 INFO - PROCESS | 32631 | RSS: Main: 184705024 08:07:33 INFO - PROCESS | 32631 | 08:07:36 INFO - PROCESS | 32631 | Cycle 1(1): loaded http://localhost:37138/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37138/tests/kraken/driver.html?testName=audio-dft) 08:07:36 INFO - PROCESS | 32631 | RSS: Main: 174104576 08:07:36 INFO - PROCESS | 32631 | 08:07:39 INFO - PROCESS | 32631 | Cycle 1(1): loaded http://localhost:37138/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37138/tests/kraken/driver.html?testName=audio-fft) 08:07:40 INFO - PROCESS | 32631 | RSS: Main: 265248768 08:07:40 INFO - PROCESS | 32631 | 08:07:42 INFO - PROCESS | 32631 | Cycle 1(1): loaded http://localhost:37138/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37138/tests/kraken/driver.html?testName=audio-oscillator) 08:07:42 INFO - PROCESS | 32631 | RSS: Main: 171679744 08:07:42 INFO - PROCESS | 32631 | 08:07:44 INFO - PROCESS | 32631 | Cycle 1(1): loaded http://localhost:37138/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37138/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:07:45 INFO - PROCESS | 32631 | RSS: Main: 174325760 08:07:45 INFO - PROCESS | 32631 | 08:07:48 INFO - PROCESS | 32631 | Cycle 1(1): loaded http://localhost:37138/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37138/tests/kraken/driver.html?testName=imaging-darkroom) 08:07:49 INFO - PROCESS | 32631 | RSS: Main: 212684800 08:07:49 INFO - PROCESS | 32631 | 08:07:52 INFO - PROCESS | 32631 | Cycle 1(1): loaded http://localhost:37138/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37138/tests/kraken/driver.html?testName=imaging-desaturate) 08:07:53 INFO - PROCESS | 32631 | RSS: Main: 212922368 08:07:53 INFO - PROCESS | 32631 | 08:07:55 INFO - PROCESS | 32631 | Cycle 1(1): loaded http://localhost:37138/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37138/tests/kraken/driver.html?testName=json-parse-financial) 08:07:56 INFO - PROCESS | 32631 | RSS: Main: 211599360 08:07:56 INFO - PROCESS | 32631 | 08:07:57 INFO - PROCESS | 32631 | Cycle 1(1): loaded http://localhost:37138/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37138/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:07:58 INFO - PROCESS | 32631 | RSS: Main: 174178304 08:07:58 INFO - PROCESS | 32631 | 08:08:00 INFO - PROCESS | 32631 | Cycle 1(1): loaded http://localhost:37138/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37138/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:08:00 INFO - PROCESS | 32631 | RSS: Main: 180609024 08:08:00 INFO - PROCESS | 32631 | 08:08:02 INFO - PROCESS | 32631 | Cycle 1(1): loaded http://localhost:37138/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37138/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:08:03 INFO - PROCESS | 32631 | RSS: Main: 186109952 08:08:03 INFO - PROCESS | 32631 | 08:08:05 INFO - PROCESS | 32631 | Cycle 1(1): loaded http://localhost:37138/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37138/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:08:06 INFO - PROCESS | 32631 | RSS: Main: 181960704 08:08:06 INFO - PROCESS | 32631 | 08:08:09 INFO - PROCESS | 32631 | Cycle 1(1): loaded http://localhost:37138/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37138/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:08:09 INFO - PROCESS | 32631 | RSS: Main: 185798656 08:08:09 INFO - PROCESS | 32631 | 08:08:11 INFO - PROCESS | 32631 | Cycle 1(1): loaded http://localhost:37138/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37138/tests/kraken/driver.html?testName=ai-astar) 08:08:11 INFO - PROCESS | 32631 | RSS: Main: 238653440 08:08:11 INFO - PROCESS | 32631 | 08:08:11 INFO - PROCESS | 32631 | __start_tp_report 08:08:11 INFO - PROCESS | 32631 | _x_x_mozilla_page_load 08:08:11 INFO - PROCESS | 32631 | _x_x_mozilla_page_load_details 08:08:11 INFO - PROCESS | 32631 | |i|pagename|runs| 08:08:11 INFO - PROCESS | 32631 | |0;ai-astar;107;116;117;115;114;115;115;115;116;114 08:08:11 INFO - PROCESS | 32631 | |1;audio-beat-detection;149;114;115;157;120;116;120;120;140;119 08:08:11 INFO - PROCESS | 32631 | |2;audio-dft;165;159;161;160;164;161;161;163;161;162 08:08:11 INFO - PROCESS | 32631 | |3;audio-fft;75;78;74;103;75;76;77;76;96;75 08:08:11 INFO - PROCESS | 32631 | |4;audio-oscillator;82;82;102;83;83;82;94;82;83;94 08:08:11 INFO - PROCESS | 32631 | |5;imaging-gaussian-blur;113;113;113;113;112;113;113;113;113;113 08:08:11 INFO - PROCESS | 32631 | |6;imaging-darkroom;147;146;147;146;146;146;146;145;175;146 08:08:11 INFO - PROCESS | 32631 | |7;imaging-desaturate;94;93;94;93;93;93;94;94;94;93 08:08:11 INFO - PROCESS | 32631 | |8;json-parse-financial;54;53;53;53;53;54;55;53;53;54 08:08:11 INFO - PROCESS | 32631 | |9;json-stringify-tinderbox;53;52;53;52;52;53;55;53;53;54 08:08:11 INFO - PROCESS | 32631 | |10;stanford-crypto-aes;76;78;77;79;80;85;79;83;80;117 08:08:11 INFO - PROCESS | 32631 | |11;stanford-crypto-ccm;122;120;132;123;119;128;127;119;131;137 08:08:11 INFO - PROCESS | 32631 | |12;stanford-crypto-pbkdf2;157;160;167;161;163;165;156;159;160;162 08:08:11 INFO - PROCESS | 32631 | |13;stanford-crypto-sha256-iterative;65;60;62;60;61;59;60;58;60;64 08:08:11 INFO - PROCESS | 32631 | __end_tp_report 08:08:11 INFO - PROCESS | 32631 | __start_cc_report 08:08:11 INFO - PROCESS | 32631 | _x_x_mozilla_cycle_collect,1636 08:08:11 INFO - PROCESS | 32631 | __end_cc_report 08:08:11 INFO - PROCESS | 32631 | __startTimestamp1495638491808__endTimestamp 08:08:11 INFO - PROCESS | 32631 | 08:08:11 INFO - PROCESS | 32631 | ------- Summary: start ------- 08:08:11 INFO - PROCESS | 32631 | Number of tests: 14 08:08:11 INFO - PROCESS | 32631 | 08:08:11 INFO - PROCESS | 32631 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.00 stddev:2.76 (2.4%) stddev-sans-first:0.97 08:08:11 INFO - PROCESS | 32631 | Values: 107.0 116.0 117.0 115.0 114.0 115.0 115.0 115.0 116.0 114.0 08:08:11 INFO - PROCESS | 32631 | 08:08:11 INFO - PROCESS | 32631 | [#1] audio-beat-detection Cycles:10 Average:127.00 Median:120.00 stddev:15.63 (13.0%) stddev-sans-first:14.41 08:08:11 INFO - PROCESS | 32631 | Values: 149.0 114.0 115.0 157.0 120.0 116.0 120.0 120.0 140.0 119.0 08:08:11 INFO - PROCESS | 32631 | 08:08:11 INFO - PROCESS | 32631 | [#2] audio-dft Cycles:10 Average:161.70 Median:161.50 stddev:1.83 (1.1%) stddev-sans-first:1.50 08:08:11 INFO - PROCESS | 32631 | Values: 165.0 159.0 161.0 160.0 164.0 161.0 161.0 163.0 161.0 162.0 08:08:11 INFO - PROCESS | 32631 | 08:08:11 INFO - PROCESS | 32631 | [#3] audio-fft Cycles:10 Average:80.50 Median:76.00 stddev:10.21 (13.4%) stddev-sans-first:10.64 08:08:11 INFO - PROCESS | 32631 | Values: 75.0 78.0 74.0 103.0 75.0 76.0 77.0 76.0 96.0 75.0 08:08:11 INFO - PROCESS | 32631 | 08:08:11 INFO - PROCESS | 32631 | [#4] audio-oscillator Cycles:10 Average:86.70 Median:83.00 stddev:7.23 (8.7%) stddev-sans-first:7.46 08:08:11 INFO - PROCESS | 32631 | Values: 82.0 82.0 102.0 83.0 83.0 82.0 94.0 82.0 83.0 94.0 08:08:11 INFO - PROCESS | 32631 | 08:08:11 INFO - PROCESS | 32631 | [#5] imaging-gaussian-blur Cycles:10 Average:112.90 Median:113.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:08:11 INFO - PROCESS | 32631 | Values: 113.0 113.0 113.0 113.0 112.0 113.0 113.0 113.0 113.0 113.0 08:08:11 INFO - PROCESS | 32631 | 08:08:11 INFO - PROCESS | 32631 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:146.00 stddev:9.15 (6.3%) stddev-sans-first:9.68 08:08:11 INFO - PROCESS | 32631 | Values: 147.0 146.0 147.0 146.0 146.0 146.0 146.0 145.0 175.0 146.0 08:08:11 INFO - PROCESS | 32631 | 08:08:11 INFO - PROCESS | 32631 | [#7] imaging-desaturate Cycles:10 Average:93.50 Median:94.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 08:08:11 INFO - PROCESS | 32631 | Values: 94.0 93.0 94.0 93.0 93.0 93.0 94.0 94.0 94.0 93.0 08:08:11 INFO - PROCESS | 32631 | 08:08:11 INFO - PROCESS | 32631 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:53.50 stddev:0.71 (1.3%) stddev-sans-first:0.73 08:08:11 INFO - PROCESS | 32631 | Values: 54.0 53.0 53.0 53.0 53.0 54.0 55.0 53.0 53.0 54.0 08:08:11 INFO - PROCESS | 32631 | 08:08:11 INFO - PROCESS | 32631 | [#9] json-stringify-tinderbox Cycles:10 Average:53.00 Median:53.00 stddev:0.94 (1.8%) stddev-sans-first:1.00 08:08:11 INFO - PROCESS | 32631 | Values: 53.0 52.0 53.0 52.0 52.0 53.0 55.0 53.0 53.0 54.0 08:08:11 INFO - PROCESS | 32631 | 08:08:11 INFO - PROCESS | 32631 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:79.50 stddev:12.10 (15.2%) stddev-sans-first:12.54 08:08:11 INFO - PROCESS | 32631 | Values: 76.0 78.0 77.0 79.0 80.0 85.0 79.0 83.0 80.0 117.0 08:08:11 INFO - PROCESS | 32631 | 08:08:11 INFO - PROCESS | 32631 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:127.50 stddev:6.20 (4.9%) stddev-sans-first:6.42 08:08:11 INFO - PROCESS | 32631 | Values: 122.0 120.0 132.0 123.0 119.0 128.0 127.0 119.0 131.0 137.0 08:08:11 INFO - PROCESS | 32631 | 08:08:11 INFO - PROCESS | 32631 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.00 Median:161.50 stddev:3.40 (2.1%) stddev-sans-first:3.28 08:08:11 INFO - PROCESS | 32631 | Values: 157.0 160.0 167.0 161.0 163.0 165.0 156.0 159.0 160.0 162.0 08:08:11 INFO - PROCESS | 32631 | 08:08:11 INFO - PROCESS | 32631 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.90 Median:60.50 stddev:2.18 (3.6%) stddev-sans-first:1.74 08:08:11 INFO - PROCESS | 32631 | Values: 65.0 60.0 62.0 60.0 61.0 59.0 60.0 58.0 60.0 64.0 08:08:11 INFO - PROCESS | 32631 | -------- Summary: end -------- 08:08:11 INFO - PROCESS | 32631 | 08:08:12 INFO - TEST-INFO | 32631: exit 0 08:08:12 INFO - TEST-OK | kraken | took 59529ms 08:08:12 INFO - SUITE-END | took 1174s 08:08:12 INFO - Completed test suite (00:19:34) 08:08:12 INFO - javascript benchmark 08:08:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7938.62303660673, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3312.7184189343902, 3375.47680109583, 3391.203067279189, 3410.4884267359876, 3425.297813948141, 5812.4768770810615, 5871.588988770788, 5883.146943693162, 5887.85280367991, 5891.8821623567555, 5880.647161170333, 5885.911711324323, 5909.143174239733, 5927.199828023216, 5929.970350148254, 5204.609654275935, 5222.3472065991755, 5235.633505654606, 5264.157734762439, 5303.867403314929, 5112.284280200756, 5132.999065182291, 5311.681299122046, 5321.414644389133, 5322.547583455411, 5163.793448262065, 5195.506426889439, 5222.164453687411, 5231.293775340338, 5239.397469291023, 5267.52592266696, 5301.6818990860675, 5304.522592966613, 5307.2039194121, 5307.814226502054, 5076.36545431821, 5176.896462070775, 5224.138017227153, 5249.8425047248265, 5310.7610157543, 5766.452187042224, 5780.7687692492245, 5801.0428279333855, 5808.3030036395485, 5813.011787996051, 6277.591956522857, 6288.768773560411, 6315.557910946236, 6325.430711235965, 6327.525435592349, 6358.618482890995, 6366.331535188831, 6370.649614271213, 6371.8407039823915, 6383.265924418705, 5719.48524632785, 5755.712214389306, 5850.356460789352, 5891.0, 5898.4101589840675, 6456.838579035561, 6458.870822583522, 6463.7091330890225, 6464.547481676237, 6472.967635161888, 6178.5366097542865, 6231.781887633911, 6244.500439964792, 6246.531510136758, 6247.468965138014, 6068.150458935753, 6116.113163591254, 6172.814815555541, 6219.720112594944, 6315.968420157962, 6234.937650623527, 6272.1219029335925, 6286.717097730521, 6287.1826662534495, 6294.685265736694, 6053.27360716708, 6100.664463454464, 6103.664298463627, 6263.467605253513, 6276.843078923063, 4698.835540756126, 4746.905061898743, 4758.547937945889, 4759.4764575896625, 4781.450133234653, 4161.646260067928, 4184.748915065105, 4190.832366705297, 4233.026403927114, 4276.273033584298, 5977.0, 5991.071383935497, 6019.548533859978, 6025.487833534199, 6045.425684559959, 6312.936870631235, 6334.651594162366, 6342.39747224013, 6360.045993101072, 6373.649449280334, 5784.2769653793275, 5991.191189189491, 6000.429959153874, 6001.789937352171, 6002.129691194752, 5278.049951008778, 5289.312389389432, 5317.1492561190025, 5327.147656374961, 5329.866753331198, 6582.308857569887, 6601.438877695354, 6632.1709786276715, 6636.734530618818, 6644.103046088813, 6291.276503202191, 6313.842153946188, 6358.459530939922, 6369.777057802955, 6373.330800266091, 6260.123582698517, 6304.275008374096, 6508.121403610641, 6535.44448721864, 6536.7712130075215, 6248.812535623939, 6248.937510625017, 6250.843728906813, 6251.499880009679, 6254.718537665907, 6345.873082538231, 6346.048092786119, 6346.333634968262, 6366.363363663597, 6374.58565193261, 5982.970085149546, 6027.095935609518, 6071.180390647382, 6122.846928826815, 6140.20177376956, 6148.723307451086, 6158.261008678808, 6198.0, 6199.876002480015, 6207.410296021871, 6181.474574661024, 6190.969045154746, 6193.792210518905, 6195.101710252078, 6198.380161983766, 5982.042873140451, 5994.940050599613, 6053.939460605514, 6116.092308610808, 6127.169935487709, 6041.2750469943885, 6046.818595442144, 6062.120992456157, 6083.148359229623, 6103.542234332354], "value": 5772.3833777490045, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [753.476333947906, 839.91600839916, 855.9400841941065, 907.0294784580501, 915.2266334946968, 31304.0, 43340.56659433405, 44272.55727442729, 44323.556764432346, 44343.556564434344, 42231.366529502004, 42470.57529424705, 42522.36216456748, 46610.0, 46715.0, 7501.887471687929, 9118.589663465127, 9256.0, 9256.768580785467, 9266.860997085048, 7592.734254301101, 10629.84055239172, 10831.67504974848, 10832.67501974942, 10841.403722795243, 10994.450277486134, 11023.118150547976, 11027.72430689231, 11030.613928512505, 11038.337699738042, 10897.182711296606, 10943.28868623541, 10960.12319014477, 10977.1218302536, 10978.890211097867, 10837.0, 10909.07272881798, 10914.56341746337, 10916.617918372818, 10918.399488028155, 43048.78475607633, 43056.569434305566, 43250.351244731355, 43254.35118473225, 43280.0, 4266.57334266574, 4305.244643428208, 4312.460942382202, 4420.226460369455, 4460.442444694413, 30650.0, 31461.37077258442, 31669.20826979321, 32288.838555807306, 32633.83683081593, 4388.188185185751, 4389.498264813825, 4439.445069366329, 4445.955540444619, 4607.585317321457, 236891.0, 238905.0, 239041.0, 239809.0, 240074.0, 54518.45481545213, 54551.45448545543, 54619.45380546223, 54743.72628136834, 54748.178777318375, 56983.0, 57281.14078288746, 57301.42698572961, 57400.0, 57433.0, 17138.0, 17287.74068388975, 17399.0, 17402.564935876704, 17413.12934353277, 12532.624021279376, 12709.872901270868, 15185.924070379577, 15250.389984400499, 15272.0, 13864.0, 14268.500602478864, 14679.045862018935, 14704.41182352694, 14829.0, 5728.79949201776, 5740.311162660508, 5755.6977209116685, 5788.88422231553, 5863.856547973104, 1000.9349392289478, 1002.2583288366702, 1003.8343673293971, 1018.1244130048152, 1031.850381694665, 28588.714112859023, 28728.71271287302, 28777.0, 29128.271793204916, 29310.12069637914, 1082.626493859617, 1087.6247694545368, 1099.263493459384, 1116.0736588631416, 1122.8764835868049, 15117.773233401507, 15386.461473848585, 15393.538193854203, 15631.921840390953, 15757.290921908541, 310335.0, 310506.0, 311046.0, 311550.0, 311686.0, 54560.454395455534, 54619.45380546144, 54706.726466367414, 54783.0, 54973.45026549763, 1460.9634759131106, 1476.9556913292618, 1496.2743069611229, 1543.8764898808067, 1547.9938040273687, 27828.0, 28687.42625147527, 29120.417591647623, 29351.119466416043, 29474.115776526738, 37376.252474949804, 37629.247415052094, 37651.0, 37670.8116459416, 37689.0, 286404.0, 288225.0, 288231.0, 288986.0, 289536.0, 24661.87669061643, 26914.461710765285, 29052.709472905, 30379.08862734033, 30678.386432271676, 37411.812940935124, 37628.435573466966, 37880.81059594794, 39033.8048309768, 39057.41413878851, 29548.409031818814, 29953.550696740003, 30070.84964575163, 30351.848240759537, 30736.538951916187, 29651.88655191174, 29705.0, 29744.0, 29885.252868678457, 29920.25199370033, 33492.832535837166, 33977.0, 34164.0, 34329.65670343264, 34433.13917152091, 28622.85688571544, 28941.421171576872, 29261.122166335044, 29269.560956585243, 29599.85200073986, 23156.536869262858, 23376.76623233746, 23412.297631071095, 23511.647325289792, 23882.880585596962], "value": 18760.986712870676, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [445.2586443571454, 449.8987727761253, 468.3069057794464, 470.6235011990407, 477.1959248665998, 19487.707684384746, 21248.7431933342, 22175.0, 22387.32838014862, 22650.77349226507, 20592.588148237064, 21058.368248952516, 22153.778462215374, 22689.773102269013, 22838.08647654096, 6658.267590565034, 6717.966410167943, 6780.1524809398825, 6853.0748348973, 6896.379325860671, 6747.291534388867, 6776.119104516406, 6820.874555698304, 6823.488238382116, 6825.897611535806, 7262.818429539251, 7539.170691223961, 7571.810704732398, 7573.848523029536, 7579.052618422697, 7540.547567145989, 7649.655765490538, 7662.310392064741, 7674.53952762836, 7701.653425595806, 7289.38040266578, 7469.365103966115, 7473.3274005339235, 7475.327220550176, 7537.0955485341565, 24701.0, 24903.128390506245, 25051.24846254615, 25079.49841003188, 25294.87352563244, 3188.3623275344794, 3216.533602627606, 3329.0678609989, 3556.5554305711785, 3744.756590821588, 14901.180435076067, 15509.302081406364, 15729.213539323102, 15907.284172212278, 15916.283767230387, 2263.9320820375415, 2345.5074434368803, 2350.659154422599, 2385.4513461903857, 2391.318474234852, 115544.0, 119102.0, 119159.0, 119377.99999999913, 120240.0, 18594.442166735018, 18736.250549978122, 18856.528586785167, 18942.537470128795, 19043.333483328017, 32038.757286990152, 32119.357612847612, 32198.19504512406, 32260.0, 32312.0, 10243.59025638981, 10259.9487002566, 10346.586136554604, 10715.303505272132, 10728.946355268174, 8751.737447876574, 8860.291176705849, 8901.866472002925, 8921.464712117293, 9105.135012173832, 9298.209652179641, 9352.298577606707, 9383.812323753487, 9652.613895444245, 9668.323217374857, 3222.436073687142, 3652.2695460907926, 3821.8849840255925, 3876.5154355705536, 3965.4250133730447, 980.2648013989508, 980.7057882635323, 981.474910922653, 988.7083310423442, 1019.5259204469957, 20981.475463113544, 21134.0, 21207.469813254793, 21251.61864478804, 21345.14619415206, 993.5876611206269, 998.8751406074241, 1005.6982905128432, 1010.4139599032543, 1021.1371391174446, 11416.42917854104, 11487.368194749202, 11836.349000805038, 11847.76304473923, 11855.76288474243, 690850.0, 778548.0, 781841.0, 795951.0, 812888.0, 115053.4247328758, 122117.0, 125961.0, 126786.0, 127339.0, 1351.9932400337934, 1388.2156581531403, 1431.3773508523618, 1435.3612642374044, 1442.4951267056447, 18759.71860422122, 19247.422577322704, 19268.4219473416, 19384.321548745727, 19540.804591954467, 38299.23401532009, 47808.760956194994, 51237.71905702238, 52783.94432111413, 55054.44945550493, 71498.64250678921, 72689.27310726825, 72779.27220727937, 73040.26959730334, 73208.63395683201, 12687.555935542212, 13054.934725326313, 13058.869411306145, 13166.934165329112, 13201.0, 13843.930780346034, 13960.930195348958, 14017.649558761113, 14215.0, 14619.780703289247, 12036.879631203576, 12092.576759813364, 12188.51245950152, 12252.142350035769, 12326.630201093982, 11668.241564298294, 11737.061035117, 11796.056315494912, 11900.702482438008, 12024.158308918291, 11876.0, 12109.273443593413, 12322.507099715911, 12427.067969902113, 12574.49702011946, 12283.508659653871, 12396.0, 12442.688932776753, 12553.811692824798, 12695.492180312684, 11994.76010479803, 12012.63962081139, 12057.81913271284, 12098.576549820715, 12273.0], "value": 11770.212392483169, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1555.7044161609294, 1565.9843401565981, 1572.90562566246, 1576.5270418874334, 1583.9841601583987, 11201.327920324786, 11964.34196119213, 11971.880281197185, 11985.041196704264, 11994.58018969334, 11338.263012904175, 11650.067994560435, 11680.0, 11999.460024298905, 12034.09744269179, 2520.4833009233107, 2548.439343344461, 2551.1963731424635, 2551.6427700122, 2554.7828434583084, 2410.843295185807, 2435.3181109289426, 2466.260121963413, 2473.826832121752, 2473.9134130305442, 2415.830891837572, 2436.463977924863, 2447.449323902126, 2450.424150324672, 2451.0, 2346.425125844162, 2347.9882600587057, 2361.421451744325, 2367.9052837886466, 2393.1504315967927, 2356.2695564374926, 2369.076060336453, 2376.988115059431, 2379.369467091205, 2379.916702915407, 11730.17888747788, 11929.522819087226, 11937.880621193764, 11958.40207989597, 11958.940205298917, 6034.0948857671265, 6155.599886007395, 6177.598456100339, 6185.288691800455, 6187.907181392283, 3592.5329707137903, 3614.855405783792, 3683.1344634010984, 3715.8327875245677, 3718.3121122592406, 1325.6345963657352, 1328.4154971812372, 1346.3470216944775, 1358.9796153057712, 1418.7446259673254, 17952.730709039373, 17971.640567188584, 18109.275628974694, 18168.727469087975, 18242.543936401562, 4763.356946812205, 4786.841354056937, 4865.440474345425, 4944.233643785219, 5043.87390315245, 13496.39266233022, 13508.662283442993, 13528.0, 13558.525451609343, 13618.250996195304, 6143.232095988002, 6159.630422174684, 6166.969165154145, 6167.259928808482, 6168.290646575611, 5528.668279903219, 5553.083741182741, 5606.6636001840025, 5629.211910332557, 5636.18275350072, 4079.755674519241, 4127.731697439657, 4170.218280968821, 4195.853145139967, 4213.052063285736, 1061.0503599278757, 1063.3566692151292, 1069.6042464288264, 1085.3108276244484, 1086.2396322574073, 888.1961824548794, 920.6455514626917, 950.8240975419569, 955.245356168619, 1107.9113670906308, 7334.046573945459, 7532.17146113927, 7545.283198096172, 7559.0, 7633.274838890296, 1146.7018575170516, 1157.3345326437332, 1159.1654009113424, 1173.5481839491686, 1177.988220117788, 5050.9494905051215, 5064.265681476165, 5066.620003499752, 5114.565261952701, 5200.947990520122, 14090.436382544789, 14712.117272963442, 14797.482088126864, 15337.386504539916, 15386.538403847902, 12887.35563221854, 15049.699006020037, 15067.547973560811, 15073.170975596448, 15086.849131508763, 9290.210332121846, 10296.433696146783, 10352.378857268588, 10494.947525262478, 10600.575976960989, 7446.255374462727, 7508.812279693051, 7708.113566939874, 7732.652030658746, 7764.767056988299, 12658.493660253855, 13151.473941042252, 13177.27524986135, 13294.667633309246, 13725.245111518961, 13590.116642418212, 13596.59210223695, 13633.0, 13747.518836841062, 13786.0, 9989.300748947504, 10237.078662920372, 10283.588656453658, 10286.0, 10306.072453479223, 11001.669949901516, 11006.174536909604, 11081.889181108409, 11177.273477223955, 11217.71955701114, 9350.766230844283, 9401.905980940102, 9441.716748497556, 9525.285603579898, 9790.461524616214, 9419.0, 9546.379485333431, 9592.376495527767, 9649.614015439585, 9727.270454716067, 8357.749267521984, 8378.53918034514, 8467.618957147066, 8487.91512084896, 8588.484690918314, 6217.240384711063, 6345.524085693683, 6365.681715914278, 6471.579347342407, 6479.967600161969, 6914.654267286515, 6963.268856770169, 7097.396721278749, 7102.218755936739, 7225.277472252943], "value": 5555.468114117806, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.6265729514789, 414.5191577769788, 416.716632689771, 424.45245633133277, 435.9934600980985, 5309.0709125903, 5348.973255133724, 5358.249845021695, 5364.704941228231, 5375.790447149399, 5102.77037533311, 5105.243168688913, 5293.9735301323435, 5296.364436267643, 5325.337331334333, 4213.705040647156, 4216.97891510542, 4220.514640816307, 4236.343366778139, 4244.80898359573, 4244.575542445747, 4252.425922500469, 4267.551907049761, 4283.164782867342, 4304.827806887721, 4234.428352172464, 4309.612134907858, 4391.780410979454, 4395.406620106292, 4456.754878481682, 4396.054643388937, 4402.581754733295, 4409.228385032607, 4415.558444155591, 4420.1380730757355, 4128.091819799639, 4143.958560414418, 4149.771762553059, 4167.729097608676, 4185.6232939035635, 4973.2291494818, 5144.794208231666, 5193.246979188034, 5287.365516138088, 5325.547328477084, 5160.922586161173, 5165.502004418714, 5171.4052883918075, 5187.610929180289, 5196.8960620787375, 5577.597665424088, 5587.636803607793, 5633.32400111985, 5685.374608793029, 5686.118651609007, 4434.246178149722, 4633.374494443241, 4659.930101048487, 4665.86002419928, 4695.366125573072, 5508.779648814083, 5564.387917329131, 5771.855703607402, 5810.588605728618, 5821.50517206038, 4715.056988602293, 4772.212584923449, 4780.856574302777, 4784.378030856036, 4791.652090475642, 4604.700694454917, 4718.197906355927, 4838.927416088762, 4868.3427737255015, 4869.220924652039, 5033.245013248042, 5146.768395422215, 5146.845594632167, 5166.173412254021, 5182.714950677673, 5579.637323573955, 5597.0, 5599.0, 5601.7396085880355, 5619.904118696815, 1618.627715625389, 1655.188957410884, 1656.6521030583713, 1678.8321167883357, 1686.6205103851535, 1271.3134907150036, 1277.4506962006426, 1315.6579289384638, 1321.2931081871152, 1324.364305133522, 5481.75332110056, 5495.175723641486, 5499.780008799683, 5512.200730893998, 5555.805546805923, 5789.768409263583, 5793.478586927113, 5798.0, 5800.709964501758, 5805.332386775491, 5306.416294207634, 5397.892042159135, 5450.809221677222, 5453.4273901240595, 5456.972715136399, 2995.4907665696883, 3015.130619016224, 3022.8790848366257, 3025.4705426550704, 3025.788194826341, 5819.592628515963, 5949.196858424058, 5989.490893274034, 6004.399560044048, 6009.669468179292, 5762.337331206881, 5812.854678632983, 5820.941790582125, 5886.3230728465915, 5907.763689452459, 5947.464728174485, 5957.510622344414, 5979.9402005980255, 6026.323942395048, 6034.818955431344, 5320.866978325418, 5636.549076073822, 5688.260526131577, 5691.601587888974, 5736.512396446349, 5420.457954204548, 5462.945370546244, 5482.53286021284, 5613.435468477628, 5640.0, 5862.970685146547, 5899.734511946886, 5933.753911678596, 5947.256592925884, 6045.335013148462, 4641.769930968228, 4820.783064762024, 4826.841558025978, 4832.975835120802, 4835.226363781919, 5738.799142030009, 5743.4256574342235, 5750.9424905752085, 5789.710514474175, 5834.970825145847, 5597.748101335531, 5600.991821472174, 5625.381208067028, 5681.289838770153, 5685.0, 5288.250109942731, 5505.9724701376235, 5545.279113715191, 5592.5525957922455, 5606.327240731139, 5549.389567147691, 5554.611177217556, 5574.16387541872, 5584.385717570983, 5585.3297604287745, 5605.299337582802, 5607.579431542569, 5639.689817060101, 5641.830745077655, 5657.038303488499, 5251.842444726664, 5496.862578435571, 5502.669839809624, 5505.339359276913, 5525.171224316385], "value": 4480.833507542759, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [857.734102428247, 886.4946980221273, 911.8723378726979, 931.1386967055472, 935.1116439382592, 16649.0, 16678.33286668532, 16934.98390096595, 17464.476065718016, 18936.147873345697, 17159.0, 17369.652606947853, 17601.55996100098, 18019.0, 18256.0, 895.3061377432509, 900.2617853360231, 917.7522069041355, 929.5584597316288, 937.4047479850276, 906.9637214511412, 909.1090731083542, 910.7495438754329, 910.8770316007353, 911.4166933162782, 969.9903000970006, 972.4651441707068, 973.8441849304113, 975.2588033094863, 975.2929126383386, 956.7321150077989, 957.5164541906362, 960.6973803251954, 961.9374740641836, 962.0523784072718, 710.836507603249, 710.9537880037781, 712.2165617820408, 712.8360477090247, 712.8538649576824, 18083.72874406885, 18113.36603218881, 18395.816041839546, 19219.231230750753, 19439.708404373945, 15963.521094367188, 16300.592485187964, 16346.918265408716, 16354.509364719077, 16691.66616667672, 13766.449342026306, 14021.719565608733, 14127.576172714835, 14203.715925681428, 14314.856851431456, 3866.323393406171, 3931.8230679619487, 3935.429362742415, 3976.5426975897853, 4081.918361632751, 52220.0, 55947.16079258774, 74259.62870185614, 81382.0, 88597.55701221517, 12725.872741272655, 13062.0, 13181.406836692371, 13190.340482975813, 13191.40638671243, 23470.413239669146, 23609.05563777464, 23636.645450317916, 23713.7628623715, 23880.88059559691, 9018.425060471222, 9264.629414823467, 9279.072092790668, 9303.488308142982, 9434.292428067785, 5082.872928176826, 5123.487651234921, 5143.151380022329, 5153.407358153785, 5225.529702326809, 3872.593377695358, 3970.940435893464, 3971.6624086952356, 3975.4434379186937, 3975.5030621172355, 647.7150053976329, 657.7763560389491, 660.1550015979553, 663.4095654867172, 665.8335416145964, 808.7735434078468, 852.2074470742145, 869.7173418638841, 880.6081293824187, 904.2856143646577, 11058.612948546763, 11935.283882966876, 11985.880141198477, 12374.257544547356, 12457.0, 710.1229980973494, 715.1061173533084, 729.8795698709654, 734.3867870328336, 739.7078154129197, 4761.190597598416, 4993.550580447777, 4997.825076122318, 5041.092603331363, 5043.117454445457, 83015.58492207501, 84425.57787211024, 86548.0, 87433.56283218543, 89003.0, 44864.55135448604, 47476.28785568219, 60674.69662651658, 61330.0, 76896.0, 59673.70163149243, 60534.39465605376, 60671.0, 60711.08933366003, 62096.68951655303, 10737.302075365076, 11064.114870810477, 11282.492287846902, 11382.14633902444, 11398.145139114433, 41487.0, 42675.57324426716, 43068.0, 43878.561214387446, 44552.33171502495, 51058.74470627623, 51100.233496498324, 51107.488925111764, 52790.73604631952, 53604.73197633987, 13540.72918541604, 13651.249181294726, 13736.500651735385, 14034.508792192224, 14187.574372768833, 13989.23059231752, 15454.227288635748, 15750.9212453937, 15858.365665373256, 16040.117793521002, 14677.266136693337, 14682.41270349174, 14800.851991479947, 14854.331555080264, 14885.330160143036, 15468.303926323568, 15538.378464861731, 15550.300236489611, 15588.766168507254, 16406.507804765875, 15346.386144554539, 15483.071015739091, 15524.456644017406, 15846.524604261891, 16290.918545407198, 10446.42544660051, 10498.64348377129, 10865.945670271598, 11047.72380690489, 11070.169737269576, 11256.606018789631, 11335.433228338385, 11662.475188616701, 11667.183297169116, 11701.06391488696], "value": 7887.861578102716, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1463.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 116.0, 117.0, 115.0, 114.0, 115.0, 115.0, 115.0, 116.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 114.0, 115.0, 157.0, 120.0, 116.0, 120.0, 120.0, 140.0, 119.0], "value": 127.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 159.0, 161.0, 160.0, 164.0, 161.0, 161.0, 163.0, 161.0, 162.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 74.0, 103.0, 75.0, 76.0, 77.0, 76.0, 96.0, 75.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 102.0, 83.0, 83.0, 82.0, 94.0, 82.0, 83.0, 94.0], "value": 86.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 112.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 175.0, 146.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 93.0, 93.0, 93.0, 94.0, 94.0, 94.0, 93.0], "value": 93.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 53.0, 53.0, 54.0, 55.0, 53.0, 53.0, 54.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 52.0, 52.0, 53.0, 55.0, 53.0, 53.0, 54.0], "value": 53.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 77.0, 79.0, 80.0, 85.0, 79.0, 83.0, 80.0, 117.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 120.0, 132.0, 123.0, 119.0, 128.0, 127.0, 119.0, 131.0, 137.0], "value": 125.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 160.0, 167.0, 161.0, 163.0, 165.0, 156.0, 159.0, 160.0, 162.0], "value": 161.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 60.0, 62.0, 60.0, 61.0, 59.0, 60.0, 58.0, 60.0, 64.0], "value": 60.9, "unit": "score"}]}]} 08:08:13 INFO - Return code: 0 08:08:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:08:13 INFO - # TBPL SUCCESS # 08:08:13 INFO - Running post-action listener: _resource_record_post_action 08:08:13 INFO - [mozharness: 2017-05-24 15:08:13.103439Z] Finished run-tests step (success) 08:08:13 INFO - Running post-run listener: _resource_record_post_run 08:08:13 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 12288; Write bytes: 329125888; Read time: 400; Write time: 175376 08:08:13 INFO - TinderboxPrint: CPU usage
13.1% 08:08:13 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 400 08:08:13 INFO - TinderboxPrint: I/O write bytes / time
329,125,888 / 175,376 08:08:13 INFO - TinderboxPrint: CPU idle
8,247.6 (86.9%) 08:08:13 INFO - TinderboxPrint: CPU user
1,200.7 (12.6%) 08:08:13 INFO - TinderboxPrint: Swap in / out
0 / 0 08:08:13 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 204800; Read time: 0; Write time: 40 08:08:13 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 260907008; Read time: 164; Write time: 131552 08:08:13 INFO - Running post-run listener: _upload_blobber_files 08:08:13 INFO - Blob upload gear active. 08:08:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:08:13 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 08:08:13 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'] 08:08:13 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 08:08:14 INFO - (blobuploader) - INFO - Open directory for files ... 08:08:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:08:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:08:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:08:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:08:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:08:14 INFO - (blobuploader) - INFO - Done attempting. 08:08:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:08:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:08:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:08:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:08:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:08:19 INFO - (blobuploader) - INFO - Done attempting. 08:08:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:08:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:08:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:08:20 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:08:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:08:20 INFO - (blobuploader) - INFO - Done attempting. 08:08:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:08:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:08:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:08:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:08:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:08:22 INFO - (blobuploader) - INFO - Done attempting. 08:08:22 INFO - (blobuploader) - INFO - Iteration through files over. 08:08:22 INFO - Return code: 0 08:08:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:08:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:08:22 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/9078344a8e6c150fc976f834b44fa0349d850615473f3fdfb160cf40ce8fdaff5df9621e8cd97de3730755923c3d13524ea9af9da1cd7fdfbfda85525739d327", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4b87f35b8ec8a834719f368dc22b0115772df2929582c8c71f8d12310bb644529261212f95b64730f3721af93dd702fde78d916b1763ddba3f32c001fa5975e1", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5cfa03cda251004bbff661d7614239d24128176630abf049a6faf551cd72a35ffb36fffd17056555ee5ea46ad5675450cce55a67e7e82aa680f85d3320ccba63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4cfbc687ee3acffd378ac568841fd163c8cb0f990f8f9bc3e0dd842ed7cce86dc3cde740f3f2949c8b989057aea87d84a2bf38527dc35802538faea1316540e1"} 08:08:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:08:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:08:22 INFO - Contents: 08:08:22 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/9078344a8e6c150fc976f834b44fa0349d850615473f3fdfb160cf40ce8fdaff5df9621e8cd97de3730755923c3d13524ea9af9da1cd7fdfbfda85525739d327", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4b87f35b8ec8a834719f368dc22b0115772df2929582c8c71f8d12310bb644529261212f95b64730f3721af93dd702fde78d916b1763ddba3f32c001fa5975e1", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5cfa03cda251004bbff661d7614239d24128176630abf049a6faf551cd72a35ffb36fffd17056555ee5ea46ad5675450cce55a67e7e82aa680f85d3320ccba63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4cfbc687ee3acffd378ac568841fd163c8cb0f990f8f9bc3e0dd842ed7cce86dc3cde740f3f2949c8b989057aea87d84a2bf38527dc35802538faea1316540e1"} 08:08:22 INFO - Running post-run listener: copy_logs_to_upload_dir 08:08:22 INFO - Copying logs to upload dir... 08:08:22 INFO - mkdir: /builds/slave/test/build/upload/logs 08:08:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.644326 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-05-24 08:08:21.561118) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-24 08:08:21.564660) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1495637255.841561-1340262720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/9078344a8e6c150fc976f834b44fa0349d850615473f3fdfb160cf40ce8fdaff5df9621e8cd97de3730755923c3d13524ea9af9da1cd7fdfbfda85525739d327", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4b87f35b8ec8a834719f368dc22b0115772df2929582c8c71f8d12310bb644529261212f95b64730f3721af93dd702fde78d916b1763ddba3f32c001fa5975e1", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5cfa03cda251004bbff661d7614239d24128176630abf049a6faf551cd72a35ffb36fffd17056555ee5ea46ad5675450cce55a67e7e82aa680f85d3320ccba63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4cfbc687ee3acffd378ac568841fd163c8cb0f990f8f9bc3e0dd842ed7cce86dc3cde740f3f2949c8b989057aea87d84a2bf38527dc35802538faea1316540e1"} build_url:https://queue.taskcluster.net/v1/task/Sw4LfCkoRPCFVmByx_5YBQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011261 build_url: 'https://queue.taskcluster.net/v1/task/Sw4LfCkoRPCFVmByx_5YBQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/9078344a8e6c150fc976f834b44fa0349d850615473f3fdfb160cf40ce8fdaff5df9621e8cd97de3730755923c3d13524ea9af9da1cd7fdfbfda85525739d327", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4b87f35b8ec8a834719f368dc22b0115772df2929582c8c71f8d12310bb644529261212f95b64730f3721af93dd702fde78d916b1763ddba3f32c001fa5975e1", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5cfa03cda251004bbff661d7614239d24128176630abf049a6faf551cd72a35ffb36fffd17056555ee5ea46ad5675450cce55a67e7e82aa680f85d3320ccba63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4cfbc687ee3acffd378ac568841fd163c8cb0f990f8f9bc3e0dd842ed7cce86dc3cde740f3f2949c8b989057aea87d84a2bf38527dc35802538faea1316540e1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-24 08:08:21.588592) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 08:08:21.588882) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1495637255.841561-1340262720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004542 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 08:08:21.672167) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-24 08:08:21.672487) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-24 08:08:21.672770) ========= ========= Total master_lag: 0.16 =========