builder: mozilla-beta_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-056 starttime: 1495031076.11 results: success (0) revision: 444be25337e3b9de1e5cdb0a4a0a6799c065a4ce ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-17 07:24:36.109737) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-17 07:24:36.110226) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-17 07:24:36.110556) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-17 07:24:36.126053) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 07:24:36.126486) ========= 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=52faae308a556c440401f8e5000001e8-1495031075.688370-235474031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-17 07:24: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2017-05-17 07:24:36 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130141 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 07:24:36.267839) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 07:24:36.268209) ========= 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=52faae308a556c440401f8e5000001e8-1495031075.688370-235474031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018752 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 07:24:36.322712) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 07:24:36.323110) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 444be25337e3b9de1e5cdb0a4a0a6799c065a4ce --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 444be25337e3b9de1e5cdb0a4a0a6799c065a4ce --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=52faae308a556c440401f8e5000001e8-1495031075.688370-235474031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-17 07:24:36,797 truncating revision to first 12 chars 2017-05-17 07:24:36,797 Setting DEBUG logging. 2017-05-17 07:24:36,797 attempt 1/10 2017-05-17 07:24:36,797 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/444be25337e3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-17 07:24:37,419 unpacking tar archive at: mozilla-beta-444be25337e3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.931980 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 07:24:37.267605) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-17 07:24:37.267965) ========= script_repo_revision: 444be25337e3b9de1e5cdb0a4a0a6799c065a4ce ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-17 07:24:37.268398) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-17 07:24:37.268701) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-17 07:24:37.281118) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-05-17 07:24:37.281433) ========= /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=52faae308a556c440401f8e5000001e8-1495031075.688370-235474031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:24:37 INFO - MultiFileLogger online at 20170517 07:24:37 in /builds/slave/test 07:24: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:24:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:24:37 INFO - {'append_to_log': False, 07:24:37 INFO - 'base_work_dir': '/builds/slave/test', 07:24:37 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 07:24:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:24:37 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 07:24:37 INFO - 'buildbot_json_path': 'buildprops.json', 07:24:37 INFO - 'config_files': ('talos/linux_config.py',), 07:24:37 INFO - 'default_actions': ('clobber', 07:24:37 INFO - 'read-buildbot-config', 07:24:37 INFO - 'download-and-extract', 07:24:37 INFO - 'populate-webroot', 07:24:37 INFO - 'create-virtualenv', 07:24:37 INFO - 'install', 07:24:37 INFO - 'run-tests'), 07:24:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:24:37 INFO - 'download_minidump_stackwalk': True, 07:24:37 INFO - 'download_symbols': 'ondemand', 07:24:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:24:37 INFO - 'tooltool.py': '/tools/tooltool.py', 07:24:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:24:37 INFO - '/tools/misc-python/virtualenv.py')}, 07:24:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:24:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:24:37 INFO - 'gecko_profile': False, 07:24:37 INFO - 'gecko_profile_interval': 0, 07:24:37 INFO - 'installer_path': 'installer.exe', 07:24:37 INFO - 'log_level': 'info', 07:24:37 INFO - 'log_name': 'talos', 07:24:37 INFO - 'log_to_console': True, 07:24:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:24:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:24:37 INFO - 'opt_config_files': (), 07:24:37 INFO - 'pip_index': False, 07:24:37 INFO - 'suite': 'dromaeojs', 07:24:37 INFO - 'system_bits': '32', 07:24:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:24:37 INFO - 'title': 'talos-linux64-ix-056', 07:24:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:24:37 INFO - 'use_talos_json': True, 07:24:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:24:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:24:37 INFO - 'work_dir': 'build'} 07:24:37 INFO - [mozharness: 2017-05-17 14:24:37.850026Z] Running clobber step. 07:24:37 INFO - Running pre-action listener: _resource_record_pre_action 07:24:37 INFO - Running main action method: clobber 07:24:37 INFO - rmtree: /builds/slave/test/build 07:24:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:24:39 INFO - Running post-action listener: _resource_record_post_action 07:24:39 INFO - [mozharness: 2017-05-17 14:24:39.553548Z] Finished clobber step (success) 07:24:39 INFO - [mozharness: 2017-05-17 14:24:39.553647Z] Running read-buildbot-config step. 07:24:39 INFO - Running pre-action listener: _resource_record_pre_action 07:24:39 INFO - Running main action method: read_buildbot_config 07:24:39 INFO - Using buildbot properties: 07:24:39 INFO - { 07:24:39 INFO - "project": "", 07:24:39 INFO - "product": "firefox", 07:24:39 INFO - "who": "ryanvm@gmail.com", 07:24:39 INFO - "installer_path": "public/build/target.tar.bz2", 07:24:39 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 07:24:39 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta/", 07:24:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs", 07:24:39 INFO - "stage_platform": "linux64", 07:24:39 INFO - "basedir": "/builds/slave/test", 07:24:39 INFO - "buildnumber": 49, 07:24:39 INFO - "platform": "ubuntu64_hw", 07:24:39 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:24:39 INFO - "slavebuilddir": "test", 07:24:39 INFO - "taskId": "erHkd0DeTri6nJtGoTWyKA", 07:24:39 INFO - "branch": "mozilla-beta", 07:24:39 INFO - "script_repo_revision": "production", 07:24:39 INFO - "revision": "444be25337e3b9de1e5cdb0a4a0a6799c065a4ce", 07:24:39 INFO - "slavename": "talos-linux64-ix-056", 07:24:39 INFO - "repo_path": "releases/mozilla-beta" 07:24:39 INFO - } 07:24:39 INFO - Finding installer, test and symbols from parent task. 07:24:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/erHkd0DeTri6nJtGoTWyKA'}, attempt #1 07:24:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/erHkd0DeTri6nJtGoTWyKA'}, attempt #1 07:24:40 INFO - Task dependencies: SLcf356FSVybdxPEpLtiVg 07:24:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SLcf356FSVybdxPEpLtiVg'}, attempt #1 07:24:40 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/SLcf356FSVybdxPEpLtiVg/artifacts/public/build/target.tar.bz2 07:24:40 INFO - Set test_url: https://queue.taskcluster.net/v1/task/SLcf356FSVybdxPEpLtiVg/artifacts/public/build/test_packages.json 07:24:40 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/SLcf356FSVybdxPEpLtiVg/artifacts/public/build/target.crashreporter-symbols.zip 07:24:40 INFO - Running post-action listener: _resource_record_post_action 07:24:40 INFO - [mozharness: 2017-05-17 14:24:40.911190Z] Finished read-buildbot-config step (success) 07:24:40 INFO - [mozharness: 2017-05-17 14:24:40.911407Z] Running download-and-extract step. 07:24:40 INFO - Running pre-action listener: _resource_record_pre_action 07:24:40 INFO - Running main action method: download_and_extract 07:24:40 INFO - mkdir: /builds/slave/test/build/tests 07:24: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:24:40 INFO - trying https://queue.taskcluster.net/v1/task/SLcf356FSVybdxPEpLtiVg/artifacts/public/build/target.test_packages.json 07:24:40 INFO - Downloading https://queue.taskcluster.net/v1/task/SLcf356FSVybdxPEpLtiVg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:24:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SLcf356FSVybdxPEpLtiVg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:24:41 INFO - Downloaded 986 bytes. 07:24:41 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:24:41 INFO - Using the following test package requirements: 07:24:41 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:24:41 INFO - u'common': [u'target.common.tests.zip'], 07:24:41 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:24:41 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:24:41 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:24:41 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:24:41 INFO - u'mozbase': [u'target.common.tests.zip'], 07:24:41 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:24:41 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:24:41 INFO - u'web-platform': [u'target.common.tests.zip', 07:24:41 INFO - u'target.web-platform.tests.zip'], 07:24:41 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:24:41 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:24:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SLcf356FSVybdxPEpLtiVg/artifacts/public/build/target.common.tests.zip 07:24:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SLcf356FSVybdxPEpLtiVg/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:24:41 INFO - Fetch https://queue.taskcluster.net/v1/task/SLcf356FSVybdxPEpLtiVg/artifacts/public/build/target.common.tests.zip into memory 07:24:42 INFO - Expected file size: 59545368 07:24:42 INFO - Obtained file size: 59545368 07:24:52 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:24:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SLcf356FSVybdxPEpLtiVg/artifacts/public/build/target.common.tests.zip 07:24:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SLcf356FSVybdxPEpLtiVg/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:24:52 INFO - Fetch https://queue.taskcluster.net/v1/task/SLcf356FSVybdxPEpLtiVg/artifacts/public/build/target.common.tests.zip into memory 07:24:53 INFO - Expected file size: 59545368 07:24:53 INFO - Obtained file size: 59545368 07:25:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SLcf356FSVybdxPEpLtiVg/artifacts/public/build/target.talos.tests.zip 07:25:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SLcf356FSVybdxPEpLtiVg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:25:04 INFO - Fetch https://queue.taskcluster.net/v1/task/SLcf356FSVybdxPEpLtiVg/artifacts/public/build/target.talos.tests.zip into memory 07:25:04 INFO - Expected file size: 14404449 07:25:04 INFO - Obtained file size: 14404449 07:25:05 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:25:05 INFO - trying https://queue.taskcluster.net/v1/task/SLcf356FSVybdxPEpLtiVg/artifacts/public/build/target.tar.bz2 07:25:05 INFO - Downloading https://queue.taskcluster.net/v1/task/SLcf356FSVybdxPEpLtiVg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:25:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SLcf356FSVybdxPEpLtiVg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:25:06 INFO - Downloaded 59830657 bytes. 07:25:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SLcf356FSVybdxPEpLtiVg/artifacts/public/build/target.tar.bz2 07:25:06 INFO - mkdir: /builds/slave/test/properties 07:25:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:25:06 INFO - Writing to file /builds/slave/test/properties/build_url 07:25:06 INFO - Contents: 07:25:06 INFO - build_url:https://queue.taskcluster.net/v1/task/SLcf356FSVybdxPEpLtiVg/artifacts/public/build/target.tar.bz2 07:25:06 INFO - Running post-action listener: _resource_record_post_action 07:25:06 INFO - Running post-action listener: set_extra_try_arguments 07:25:06 INFO - [mozharness: 2017-05-17 14:25:06.174783Z] Finished download-and-extract step (success) 07:25:06 INFO - [mozharness: 2017-05-17 14:25:06.174880Z] Running populate-webroot step. 07:25:06 INFO - Running pre-action listener: _resource_record_pre_action 07:25:06 INFO - Running main action method: populate_webroot 07:25:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:25:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:25:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:25:06 INFO - '--tppagecycles', 07:25:06 INFO - '7'], 07:25:06 INFO - 'tests': ['tsvgm']}}, 07:25:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:25:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:25:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:25:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:25:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:25:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:25:06 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:25:06 INFO - 'talos_options': ['--disable-e10s'], 07:25:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:25:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:25:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:25:06 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:25:06 INFO - 'talos_options': ['--disable-e10s'], 07:25:06 INFO - 'tests': ['damp', 'tps']}, 07:25:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:25:06 INFO - 'tests': ['damp', 'tps']}, 07:25:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:25:06 INFO - 'tests': ['dromaeo_dom']}, 07:25:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:25:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:25:06 INFO - 'tests': ['basic_compositor_video']}, 07:25:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:25:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:25:06 INFO - 'tests': ['a11yr', 07:25:06 INFO - 'ts_paint', 07:25:06 INFO - 'tpaint', 07:25:06 INFO - 'sessionrestore', 07:25:06 INFO - 'sessionrestore_no_auto_restore', 07:25:06 INFO - 'tabpaint']}, 07:25:06 INFO - 'other-e10s': {'tests': ['a11yr', 07:25:06 INFO - 'ts_paint', 07:25:06 INFO - 'tpaint', 07:25:06 INFO - 'sessionrestore', 07:25:06 INFO - 'sessionrestore_no_auto_restore', 07:25:06 INFO - 'tabpaint']}, 07:25:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:25:06 INFO - 'ts_paint', 07:25:06 INFO - 'tpaint', 07:25:06 INFO - 'sessionrestore', 07:25:06 INFO - 'sessionrestore_no_auto_restore', 07:25:06 INFO - 'tabpaint']}, 07:25:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:25:06 INFO - 'ts_paint', 07:25:06 INFO - 'tpaint', 07:25:06 INFO - 'sessionrestore', 07:25:06 INFO - 'sessionrestore_no_auto_restore', 07:25:06 INFO - 'tabpaint']}, 07:25:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:25:06 INFO - 'tests': ['a11yr', 07:25:06 INFO - 'ts_paint', 07:25:06 INFO - 'tpaint', 07:25:06 INFO - 'sessionrestore', 07:25:06 INFO - 'sessionrestore_no_auto_restore', 07:25:06 INFO - 'tabpaint']}, 07:25:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:25:06 INFO - 'tests': ['a11yr', 07:25:06 INFO - 'ts_paint', 07:25:06 INFO - 'tpaint', 07:25:06 INFO - 'sessionrestore', 07:25:06 INFO - 'sessionrestore_no_auto_restore', 07:25:06 INFO - 'tabpaint']}, 07:25:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:25:06 INFO - 'tests': ['tsvgx', 07:25:06 INFO - 'tsvgr_opacity', 07:25:06 INFO - 'tart', 07:25:06 INFO - 'tscrollx', 07:25:06 INFO - 'cart', 07:25:06 INFO - 'tsvg_static']}, 07:25:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:25:06 INFO - 'tsvgr_opacity', 07:25:06 INFO - 'tart', 07:25:06 INFO - 'tscrollx', 07:25:06 INFO - 'cart', 07:25:06 INFO - 'tsvg_static']}, 07:25:06 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:25:06 INFO - 'talos_options': ['--disable-e10s'], 07:25:06 INFO - 'tests': ['tp5o']}, 07:25:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:25:06 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:25:06 INFO - 'talos_options': ['--disable-e10s', 07:25:06 INFO - '--xperf_path', 07:25:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:25:06 INFO - 'tests': ['tp5n']}, 07:25:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:25:06 INFO - 'talos_options': ['--xperf_path', 07:25:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:25:06 INFO - 'tests': ['tp5n']}}, 07:25:06 INFO - 'talos.zip': {'path': '', 07:25:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:25:06 INFO - Running post-action listener: _resource_record_post_action 07:25:06 INFO - [mozharness: 2017-05-17 14:25:06.187985Z] Finished populate-webroot step (success) 07:25:06 INFO - [mozharness: 2017-05-17 14:25:06.188075Z] Running create-virtualenv step. 07:25:06 INFO - Running pre-action listener: _resource_record_pre_action 07:25:06 INFO - Running main action method: create_virtualenv 07:25:06 INFO - Creating virtualenv /builds/slave/test/build/venv 07:25:06 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:25:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:25:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:25:06 INFO - Using real prefix '/usr' 07:25:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:25:06 INFO - Installing distribute.............................................................................................................................................................................................done. 07:25:08 INFO - Installing pip.................done. 07:25:08 INFO - Return code: 0 07:25:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:25:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:25:08 INFO - Reading from file tmpfile_stdout 07:25:08 INFO - Output received: 07:25: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:25:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:25: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:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25: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:25:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25: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 0x14b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1753310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750400>, '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 0x17513b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1751840>, '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': '52faae308a556c440401f8e5000001e8-1495031075.688370-235474031', '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:25: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:25: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:25:08 INFO - Using env: {'DISPLAY': ':0', 07:25:08 INFO - 'HOME': '/home/cltbld', 07:25:08 INFO - 'LANG': 'en_US.UTF-8', 07:25:08 INFO - 'LANGUAGE': 'en_US:en', 07:25:08 INFO - 'LOGNAME': 'cltbld', 07:25:08 INFO - 'MAIL': '/var/mail/cltbld', 07:25:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:08 INFO - 'MOZ_NO_REMOTE': '1', 07:25:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:08 INFO - 'NO_EM_RESTART': '1', 07:25:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:08 INFO - 'PWD': '/builds/slave/test', 07:25:08 INFO - 'SHELL': '/bin/bash', 07:25:08 INFO - 'SHLVL': '1', 07:25:08 INFO - 'TERM': 'linux', 07:25:08 INFO - 'TMOUT': '86400', 07:25:08 INFO - 'USER': 'cltbld', 07:25:08 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1495031075.688370-235474031', 07:25:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:08 INFO - '_': '/tools/buildbot/bin/python'} 07:25:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:09 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:25:09 INFO - Cleaning up... 07:25:09 INFO - Return code: 0 07:25:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:25:09 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:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:09 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:25:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:09 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 0x14b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1753310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750400>, '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 0x17513b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1751840>, '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': '52faae308a556c440401f8e5000001e8-1495031075.688370-235474031', '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:25:09 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:25:09 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:25:09 INFO - Using env: {'DISPLAY': ':0', 07:25:09 INFO - 'HOME': '/home/cltbld', 07:25:09 INFO - 'LANG': 'en_US.UTF-8', 07:25:09 INFO - 'LANGUAGE': 'en_US:en', 07:25:09 INFO - 'LOGNAME': 'cltbld', 07:25:09 INFO - 'MAIL': '/var/mail/cltbld', 07:25:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:09 INFO - 'MOZ_NO_REMOTE': '1', 07:25:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:09 INFO - 'NO_EM_RESTART': '1', 07:25:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:09 INFO - 'PWD': '/builds/slave/test', 07:25:09 INFO - 'SHELL': '/bin/bash', 07:25:09 INFO - 'SHLVL': '1', 07:25:09 INFO - 'TERM': 'linux', 07:25:09 INFO - 'TMOUT': '86400', 07:25:09 INFO - 'USER': 'cltbld', 07:25:09 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1495031075.688370-235474031', 07:25:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:09 INFO - '_': '/tools/buildbot/bin/python'} 07:25:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:09 INFO - Downloading/unpacking psutil>=3.1.1 07:25: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:25: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:25: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:25: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:25:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:25:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:25:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:25:10 INFO - Installing collected packages: psutil 07:25:10 INFO - Running setup.py install for psutil 07:25:10 INFO - building 'psutil._psutil_linux' extension 07:25: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:25: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:25:10 INFO - building 'psutil._psutil_posix' extension 07:25: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:25:11 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:25:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:25:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:25:11 INFO - Successfully installed psutil 07:25:11 INFO - Cleaning up... 07:25:11 INFO - Return code: 0 07:25:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:25:11 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:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:11 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:25:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:11 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 0x14b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1753310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750400>, '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 0x17513b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1751840>, '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': '52faae308a556c440401f8e5000001e8-1495031075.688370-235474031', '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:25:11 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:25:11 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:25:11 INFO - Using env: {'DISPLAY': ':0', 07:25:11 INFO - 'HOME': '/home/cltbld', 07:25:11 INFO - 'LANG': 'en_US.UTF-8', 07:25:11 INFO - 'LANGUAGE': 'en_US:en', 07:25:11 INFO - 'LOGNAME': 'cltbld', 07:25:11 INFO - 'MAIL': '/var/mail/cltbld', 07:25:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:11 INFO - 'MOZ_NO_REMOTE': '1', 07:25:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:11 INFO - 'NO_EM_RESTART': '1', 07:25:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:11 INFO - 'PWD': '/builds/slave/test', 07:25:11 INFO - 'SHELL': '/bin/bash', 07:25:11 INFO - 'SHLVL': '1', 07:25:11 INFO - 'TERM': 'linux', 07:25:11 INFO - 'TMOUT': '86400', 07:25:11 INFO - 'USER': 'cltbld', 07:25:11 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1495031075.688370-235474031', 07:25:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:11 INFO - '_': '/tools/buildbot/bin/python'} 07:25:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:25: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:25: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:25: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:25: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:25:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:25:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:25: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:25:12 INFO - Installing collected packages: mozsystemmonitor 07:25:12 INFO - Running setup.py install for mozsystemmonitor 07:25:12 INFO - Successfully installed mozsystemmonitor 07:25:12 INFO - Cleaning up... 07:25:12 INFO - Return code: 0 07:25:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:25: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:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25: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:25:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25: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 0x14b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1753310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750400>, '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 0x17513b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1751840>, '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': '52faae308a556c440401f8e5000001e8-1495031075.688370-235474031', '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:25: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:25: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:25:12 INFO - Using env: {'DISPLAY': ':0', 07:25:12 INFO - 'HOME': '/home/cltbld', 07:25:12 INFO - 'LANG': 'en_US.UTF-8', 07:25:12 INFO - 'LANGUAGE': 'en_US:en', 07:25:12 INFO - 'LOGNAME': 'cltbld', 07:25:12 INFO - 'MAIL': '/var/mail/cltbld', 07:25:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:12 INFO - 'MOZ_NO_REMOTE': '1', 07:25:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:12 INFO - 'NO_EM_RESTART': '1', 07:25:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:12 INFO - 'PWD': '/builds/slave/test', 07:25:12 INFO - 'SHELL': '/bin/bash', 07:25:12 INFO - 'SHLVL': '1', 07:25:12 INFO - 'TERM': 'linux', 07:25:12 INFO - 'TMOUT': '86400', 07:25:12 INFO - 'USER': 'cltbld', 07:25:12 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1495031075.688370-235474031', 07:25:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:12 INFO - '_': '/tools/buildbot/bin/python'} 07:25:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:12 INFO - Downloading/unpacking jsonschema==2.5.1 07:25: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:25: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:25: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:25: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:25:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:25:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:25: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:25: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:25: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:25: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:25:14 INFO - Downloading functools32-3.2.3-2.tar.gz 07:25:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:25:14 INFO - warning: no files found matching '*.txt' 07:25:14 INFO - no previously-included directories found matching 'build' 07:25:14 INFO - no previously-included directories found matching 'dist' 07:25:14 INFO - no previously-included directories found matching '.git*' 07:25:14 INFO - Installing collected packages: jsonschema, functools32 07:25:14 INFO - Running setup.py install for functools32 07:25:14 INFO - warning: no files found matching '*.txt' 07:25:14 INFO - no previously-included directories found matching 'build' 07:25:14 INFO - no previously-included directories found matching 'dist' 07:25:14 INFO - no previously-included directories found matching '.git*' 07:25:14 INFO - Successfully installed jsonschema functools32 07:25:14 INFO - Cleaning up... 07:25:14 INFO - Return code: 0 07:25:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:25: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:25:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25: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:25:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25: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 0x14b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1753310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750400>, '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 0x17513b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1751840>, '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': '52faae308a556c440401f8e5000001e8-1495031075.688370-235474031', '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:25: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:25: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:25:14 INFO - Using env: {'DISPLAY': ':0', 07:25:14 INFO - 'HOME': '/home/cltbld', 07:25:14 INFO - 'LANG': 'en_US.UTF-8', 07:25:14 INFO - 'LANGUAGE': 'en_US:en', 07:25:14 INFO - 'LOGNAME': 'cltbld', 07:25:14 INFO - 'MAIL': '/var/mail/cltbld', 07:25:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:14 INFO - 'MOZ_NO_REMOTE': '1', 07:25:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:14 INFO - 'NO_EM_RESTART': '1', 07:25:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:14 INFO - 'PWD': '/builds/slave/test', 07:25:14 INFO - 'SHELL': '/bin/bash', 07:25:14 INFO - 'SHLVL': '1', 07:25:14 INFO - 'TERM': 'linux', 07:25:14 INFO - 'TMOUT': '86400', 07:25:14 INFO - 'USER': 'cltbld', 07:25:14 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1495031075.688370-235474031', 07:25:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:14 INFO - '_': '/tools/buildbot/bin/python'} 07:25:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:25:14 INFO - Cleaning up... 07:25:14 INFO - Return code: 0 07:25:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:25: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:25:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25: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:25:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25: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 0x14b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1753310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750400>, '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 0x17513b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1751840>, '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': '52faae308a556c440401f8e5000001e8-1495031075.688370-235474031', '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:25: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:25: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:25:14 INFO - Using env: {'DISPLAY': ':0', 07:25:14 INFO - 'HOME': '/home/cltbld', 07:25:14 INFO - 'LANG': 'en_US.UTF-8', 07:25:14 INFO - 'LANGUAGE': 'en_US:en', 07:25:14 INFO - 'LOGNAME': 'cltbld', 07:25:14 INFO - 'MAIL': '/var/mail/cltbld', 07:25:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:14 INFO - 'MOZ_NO_REMOTE': '1', 07:25:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:14 INFO - 'NO_EM_RESTART': '1', 07:25:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:14 INFO - 'PWD': '/builds/slave/test', 07:25:14 INFO - 'SHELL': '/bin/bash', 07:25:14 INFO - 'SHLVL': '1', 07:25:14 INFO - 'TERM': 'linux', 07:25:14 INFO - 'TMOUT': '86400', 07:25:14 INFO - 'USER': 'cltbld', 07:25:14 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1495031075.688370-235474031', 07:25:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:14 INFO - '_': '/tools/buildbot/bin/python'} 07:25:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:14 INFO - Downloading/unpacking blobuploader==1.2.4 07:25: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:25: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:25: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:25: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:25:15 INFO - Downloading blobuploader-1.2.4.tar.gz 07:25:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:25:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:25: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:25: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:25: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:25: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:25:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:25:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:25: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:25: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:25: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:25: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:25:16 INFO - Downloading docopt-0.6.1.tar.gz 07:25:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:25:16 INFO - Installing collected packages: blobuploader, requests, docopt 07:25:16 INFO - Running setup.py install for blobuploader 07:25:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:25:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:25:16 INFO - Running setup.py install for requests 07:25:16 INFO - Running setup.py install for docopt 07:25:17 INFO - Successfully installed blobuploader requests docopt 07:25:17 INFO - Cleaning up... 07:25:17 INFO - Return code: 0 07:25:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:25:17 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:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:17 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:25:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:17 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 0x14b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1753310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750400>, '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 0x17513b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1751840>, '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': '52faae308a556c440401f8e5000001e8-1495031075.688370-235474031', '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:25:17 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:25:17 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:25:17 INFO - Using env: {'DISPLAY': ':0', 07:25:17 INFO - 'HOME': '/home/cltbld', 07:25:17 INFO - 'LANG': 'en_US.UTF-8', 07:25:17 INFO - 'LANGUAGE': 'en_US:en', 07:25:17 INFO - 'LOGNAME': 'cltbld', 07:25:17 INFO - 'MAIL': '/var/mail/cltbld', 07:25:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:17 INFO - 'MOZ_NO_REMOTE': '1', 07:25:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:17 INFO - 'NO_EM_RESTART': '1', 07:25:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:17 INFO - 'PWD': '/builds/slave/test', 07:25:17 INFO - 'SHELL': '/bin/bash', 07:25:17 INFO - 'SHLVL': '1', 07:25:17 INFO - 'TERM': 'linux', 07:25:17 INFO - 'TMOUT': '86400', 07:25:17 INFO - 'USER': 'cltbld', 07:25:17 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1495031075.688370-235474031', 07:25:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:17 INFO - '_': '/tools/buildbot/bin/python'} 07:25:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:25:17 INFO - Running setup.py (path:/tmp/pip-1GHrV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:25:17 INFO - Running setup.py (path:/tmp/pip-AT95hM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:25:17 INFO - Running setup.py (path:/tmp/pip-73MBqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:25:17 INFO - Running setup.py (path:/tmp/pip-yQgVm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:25:17 INFO - Running setup.py (path:/tmp/pip-KAB9CN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:25:17 INFO - Running setup.py (path:/tmp/pip-poogTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:25:17 INFO - Running setup.py (path:/tmp/pip-p9BKMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:25:17 INFO - Running setup.py (path:/tmp/pip-tKctBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:25:17 INFO - Running setup.py (path:/tmp/pip-Xchii0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:25:17 INFO - Running setup.py (path:/tmp/pip-Rwjcq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:25:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:25:18 INFO - Running setup.py (path:/tmp/pip-fNZ2ZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:25:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:25:18 INFO - Running setup.py (path:/tmp/pip-Svqh7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:25:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:25:18 INFO - Running setup.py (path:/tmp/pip-Yu43UH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:25:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:25:18 INFO - Running setup.py (path:/tmp/pip-wtI5a4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:25:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:18 INFO - Running setup.py (path:/tmp/pip-l88iHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:25:18 INFO - Running setup.py (path:/tmp/pip-9cbz8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:25:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:25:18 INFO - Running setup.py (path:/tmp/pip-4yZB1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:25:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:25:18 INFO - Running setup.py install for manifestparser 07:25:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:25:18 INFO - Running setup.py install for mozcrash 07:25:18 INFO - Running setup.py install for mozdebug 07:25:18 INFO - Running setup.py install for mozdevice 07:25:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:25:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:25:18 INFO - Running setup.py install for mozfile 07:25:19 INFO - Running setup.py install for mozhttpd 07:25:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:25:19 INFO - Running setup.py install for mozinfo 07:25:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:25:19 INFO - Running setup.py install for mozInstall 07:25:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:25:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:25:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:25:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:25:19 INFO - Running setup.py install for mozleak 07:25:19 INFO - Running setup.py install for mozlog 07:25:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:25:19 INFO - Running setup.py install for moznetwork 07:25:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:25:19 INFO - Running setup.py install for mozprocess 07:25:19 INFO - Running setup.py install for mozprofile 07:25:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:25:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:25:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:25:20 INFO - Running setup.py install for mozrunner 07:25:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:25:20 INFO - Running setup.py install for mozscreenshot 07:25:20 INFO - Running setup.py install for moztest 07:25:20 INFO - Running setup.py install for mozversion 07:25:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:25:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:25:20 INFO - Cleaning up... 07:25:20 INFO - Return code: 0 07:25:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:25: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:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25: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:25:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25: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 0x14b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1753310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750400>, '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 0x17513b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1751840>, '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': '52faae308a556c440401f8e5000001e8-1495031075.688370-235474031', '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:25: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:25: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:25:20 INFO - Using env: {'DISPLAY': ':0', 07:25:20 INFO - 'HOME': '/home/cltbld', 07:25:20 INFO - 'LANG': 'en_US.UTF-8', 07:25:20 INFO - 'LANGUAGE': 'en_US:en', 07:25:20 INFO - 'LOGNAME': 'cltbld', 07:25:20 INFO - 'MAIL': '/var/mail/cltbld', 07:25:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:20 INFO - 'MOZ_NO_REMOTE': '1', 07:25:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:20 INFO - 'NO_EM_RESTART': '1', 07:25:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:20 INFO - 'PWD': '/builds/slave/test', 07:25:20 INFO - 'SHELL': '/bin/bash', 07:25:20 INFO - 'SHLVL': '1', 07:25:20 INFO - 'TERM': 'linux', 07:25:20 INFO - 'TMOUT': '86400', 07:25:20 INFO - 'USER': 'cltbld', 07:25:20 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1495031075.688370-235474031', 07:25:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:20 INFO - '_': '/tools/buildbot/bin/python'} 07:25:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:25:20 INFO - Running setup.py (path:/tmp/pip-r6cc7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:25: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:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:25:20 INFO - Running setup.py (path:/tmp/pip-ovM3q2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:25: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:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:25:20 INFO - Running setup.py (path:/tmp/pip-DBXtde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:25: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:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:25:20 INFO - Running setup.py (path:/tmp/pip-nSehKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:25: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:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:25:20 INFO - Running setup.py (path:/tmp/pip-18JcS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:25:21 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:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:25:21 INFO - Running setup.py (path:/tmp/pip-d4_ViF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:25:21 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:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:25:21 INFO - Running setup.py (path:/tmp/pip-IlZqoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:25:21 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:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:25:21 INFO - Running setup.py (path:/tmp/pip-LusKAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:25:21 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:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:25:21 INFO - Running setup.py (path:/tmp/pip-ybCndY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:25:21 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:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:25:21 INFO - Running setup.py (path:/tmp/pip-TlOXEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:25: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:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:25:21 INFO - Running setup.py (path:/tmp/pip-PTpkKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:25: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:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:25:21 INFO - Running setup.py (path:/tmp/pip-22oNTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:25: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:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:25:21 INFO - Running setup.py (path:/tmp/pip-RKkWIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:25: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:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:25:21 INFO - Running setup.py (path:/tmp/pip-iwCYow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:25: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:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:21 INFO - Running setup.py (path:/tmp/pip-s4atAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:25: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:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:25:21 INFO - Running setup.py (path:/tmp/pip-pfOfvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:25: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:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:25:21 INFO - Running setup.py (path:/tmp/pip-Yv9Ets-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:25: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:25: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:25: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:25: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:25: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:25: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:25:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:25: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:25: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:25: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:25: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:25:23 INFO - Downloading blessings-1.6.tar.gz 07:25:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:25:23 INFO - Installing collected packages: blessings 07:25:23 INFO - Running setup.py install for blessings 07:25:23 INFO - Successfully installed blessings 07:25:23 INFO - Cleaning up... 07:25:23 INFO - Return code: 0 07:25:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:25:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:25:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:25:23 INFO - Reading from file tmpfile_stdout 07:25:23 INFO - Current package versions: 07:25:23 INFO - argparse == 1.2.1 07:25:23 INFO - blessings == 1.6 07:25:23 INFO - blobuploader == 1.2.4 07:25:23 INFO - docopt == 0.6.1 07:25:23 INFO - functools32 == 3.2.3-2 07:25:23 INFO - jsonschema == 2.5.1 07:25:23 INFO - manifestparser == 1.1 07:25:23 INFO - mozInstall == 1.12 07:25:23 INFO - mozcrash == 1.0 07:25:23 INFO - mozdebug == 0.1 07:25:23 INFO - mozdevice == 0.49 07:25:23 INFO - mozfile == 1.2 07:25:23 INFO - mozhttpd == 0.7 07:25:23 INFO - mozinfo == 0.9 07:25:23 INFO - mozleak == 0.1 07:25:23 INFO - mozlog == 3.4 07:25:23 INFO - moznetwork == 0.27 07:25:23 INFO - mozprocess == 0.25 07:25:23 INFO - mozprofile == 0.28 07:25:23 INFO - mozrunner == 6.13 07:25:23 INFO - mozscreenshot == 0.1 07:25:23 INFO - mozsystemmonitor == 0.3 07:25:23 INFO - moztest == 0.8 07:25:23 INFO - mozversion == 1.4 07:25:23 INFO - psutil == 3.1.1 07:25:23 INFO - requests == 1.2.3 07:25:23 INFO - wsgiref == 0.1.2 07:25:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:25: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:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25: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:25:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25: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 0x14b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1753310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750400>, '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 0x17513b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1751840>, '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': '52faae308a556c440401f8e5000001e8-1495031075.688370-235474031', '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:25: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:25: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:25:23 INFO - Using env: {'DISPLAY': ':0', 07:25:23 INFO - 'HOME': '/home/cltbld', 07:25:23 INFO - 'LANG': 'en_US.UTF-8', 07:25:23 INFO - 'LANGUAGE': 'en_US:en', 07:25:23 INFO - 'LOGNAME': 'cltbld', 07:25:23 INFO - 'MAIL': '/var/mail/cltbld', 07:25:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:23 INFO - 'MOZ_NO_REMOTE': '1', 07:25:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:23 INFO - 'NO_EM_RESTART': '1', 07:25:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:23 INFO - 'PWD': '/builds/slave/test', 07:25:23 INFO - 'SHELL': '/bin/bash', 07:25:23 INFO - 'SHLVL': '1', 07:25:23 INFO - 'TERM': 'linux', 07:25:23 INFO - 'TMOUT': '86400', 07:25:23 INFO - 'USER': 'cltbld', 07:25:23 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1495031075.688370-235474031', 07:25:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:23 INFO - '_': '/tools/buildbot/bin/python'} 07:25:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25: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:25: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:25: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:25: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:25: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:25: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:25: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:25: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:25: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:25: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:25: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:25:23 INFO - Cleaning up... 07:25:23 INFO - Return code: 0 07:25:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:25: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:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25: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:25:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25: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 0x14b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1753310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750400>, '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 0x17513b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1751840>, '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': '52faae308a556c440401f8e5000001e8-1495031075.688370-235474031', '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:25: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:25: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:25:23 INFO - Using env: {'DISPLAY': ':0', 07:25:23 INFO - 'HOME': '/home/cltbld', 07:25:23 INFO - 'LANG': 'en_US.UTF-8', 07:25:23 INFO - 'LANGUAGE': 'en_US:en', 07:25:23 INFO - 'LOGNAME': 'cltbld', 07:25:23 INFO - 'MAIL': '/var/mail/cltbld', 07:25:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:23 INFO - 'MOZ_NO_REMOTE': '1', 07:25:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:23 INFO - 'NO_EM_RESTART': '1', 07:25:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:23 INFO - 'PWD': '/builds/slave/test', 07:25:23 INFO - 'SHELL': '/bin/bash', 07:25:23 INFO - 'SHLVL': '1', 07:25:23 INFO - 'TERM': 'linux', 07:25:23 INFO - 'TMOUT': '86400', 07:25:23 INFO - 'USER': 'cltbld', 07:25:23 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1495031075.688370-235474031', 07:25:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:23 INFO - '_': '/tools/buildbot/bin/python'} 07:25:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:25:24 INFO - Cleaning up... 07:25:24 INFO - Return code: 0 07:25:24 INFO - Running post-action listener: _resource_record_post_action 07:25:24 INFO - Running post-action listener: _start_resource_monitoring 07:25:24 INFO - Starting resource monitoring. 07:25:24 INFO - [mozharness: 2017-05-17 14:25:24.056553Z] Finished create-virtualenv step (success) 07:25:24 INFO - [mozharness: 2017-05-17 14:25:24.057016Z] Running install step. 07:25:24 INFO - Running pre-action listener: _resource_record_pre_action 07:25:24 INFO - Running main action method: install 07:25:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:25:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:25:24 INFO - Reading from file tmpfile_stdout 07:25:24 INFO - Detecting whether we're running mozinstall >=1.0... 07:25:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:25:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:25:24 INFO - Reading from file tmpfile_stdout 07:25:24 INFO - Output received: 07:25:24 INFO - Usage: mozinstall [options] installer 07:25:24 INFO - Options: 07:25:24 INFO - -h, --help show this help message and exit 07:25:24 INFO - -d DEST, --destination=DEST 07:25:24 INFO - Directory to install application into. [default: 07:25:24 INFO - "/builds/slave/test"] 07:25:24 INFO - --app=APP Application being installed. [default: firefox] 07:25:24 INFO - mkdir: /builds/slave/test/build/application 07:25:24 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:25:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:25:38 INFO - Reading from file tmpfile_stdout 07:25:38 INFO - Output received: 07:25:38 INFO - /builds/slave/test/build/application/firefox/firefox 07:25:38 INFO - Running post-action listener: _resource_record_post_action 07:25:38 INFO - [mozharness: 2017-05-17 14:25:38.421574Z] Finished install step (success) 07:25:38 INFO - [mozharness: 2017-05-17 14:25:38.421890Z] Running run-tests step. 07:25:38 INFO - Running pre-action listener: _resource_record_pre_action 07:25:38 INFO - Running main action method: run_tests 07:25:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:25:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:25:38 INFO - Python 2.7.3 07:25:38 INFO - Return code: 0 07:25:38 INFO - grabbing minidump binary from tooltool 07:25:38 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:25:38 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 0x1750400>, '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 0x17513b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1751840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:25:38 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:25:38 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:25:38 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:25:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:25:38 INFO - Return code: 0 07:25:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:25:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:25:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:25:38 INFO - ENV: RUST_BACKTRACE is now 1 07:25:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:25:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:25: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/SLcf356FSVybdxPEpLtiVg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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:25: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/SLcf356FSVybdxPEpLtiVg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-056 --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:25:38 INFO - Using env: {'DISPLAY': ':0', 07:25:38 INFO - 'HOME': '/home/cltbld', 07:25:38 INFO - 'LANG': 'en_US.UTF-8', 07:25:38 INFO - 'LANGUAGE': 'en_US:en', 07:25:38 INFO - 'LOGNAME': 'cltbld', 07:25:38 INFO - 'MAIL': '/var/mail/cltbld', 07:25:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:25:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:25:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:38 INFO - 'MOZ_NO_REMOTE': '1', 07:25:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:25:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:38 INFO - 'NO_EM_RESTART': '1', 07:25:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:38 INFO - 'PWD': '/builds/slave/test', 07:25:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:25:38 INFO - 'RUST_BACKTRACE': '1', 07:25:38 INFO - 'SHELL': '/bin/bash', 07:25:38 INFO - 'SHLVL': '1', 07:25:38 INFO - 'TERM': 'linux', 07:25:38 INFO - 'TMOUT': '86400', 07:25:38 INFO - 'USER': 'cltbld', 07:25:38 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1495031075.688370-235474031', 07:25:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:38 INFO - '_': '/tools/buildbot/bin/python'} 07:25: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/SLcf356FSVybdxPEpLtiVg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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:25:38 INFO - mozversion application_buildid: 20170517133209 07:25:38 INFO - mozversion application_changeset: 444be25337e3b9de1e5cdb0a4a0a6799c065a4ce 07:25:38 INFO - mozversion application_display_name: Firefox 07:25:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:25:38 INFO - mozversion application_name: Firefox 07:25:38 INFO - mozversion application_remotingname: firefox 07:25:38 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:25:38 INFO - mozversion application_vendor: Mozilla 07:25:38 INFO - mozversion application_version: 54.0 07:25:38 INFO - mozversion platform_buildid: 20170517133209 07:25:38 INFO - mozversion platform_changeset: 444be25337e3b9de1e5cdb0a4a0a6799c065a4ce 07:25:38 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:25:38 INFO - mozversion platform_version: 54.0 07:25:38 INFO - using testdate: 1495031138 07:25:38 INFO - actual date: 1495031138 07:25:38 INFO - starting webserver on 'localhost:59767' 07:25:38 INFO - SUITE-START | Running 2 tests 07:25:38 INFO - TEST-START | dromaeo_css 07:25:38 INFO - operating with platform_type : linux_ 07:25:38 INFO - Initialising browser for dromaeo_css test... 07:25:38 INFO - TEST-INFO | started process 25587 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMWQfcY/profile http://localhost:59767/getInfo.html) 07:25:44 INFO - PROCESS | 25587 | __metrics Screen width/height:1600/1200 07:25:44 INFO - PROCESS | 25587 | colorDepth:24 07:25:44 INFO - PROCESS | 25587 | Browser inner width/height: 1024/697 07:25:44 INFO - PROCESS | 25587 | __metrics 07:25:45 INFO - PROCESS | 25587 | 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:25:45 INFO - PROCESS | 25587 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:25:45 INFO - PROCESS | 25587 | console.error: PushService: 07:25:45 INFO - PROCESS | 25587 | stateChangeProcessEnqueue: Error transitioning state 07:25:45 INFO - PROCESS | 25587 | UnknownError 07:25:46 INFO - TEST-INFO | 25587: exit 0 07:25:46 INFO - Browser initialized. 07:25:46 INFO - Running cycle 1/1 for dromaeo_css test... 07:25:46 INFO - TEST-INFO | started process 25679 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMWQfcY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:25:58 INFO - PROCESS | 25679 | RSS: Main: 141328384 07:25:58 INFO - PROCESS | 25679 | 07:29:00 INFO - PROCESS | 25679 | Cycle 1(1): loaded http://localhost:59767/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59767/tests/dromaeo/cssquery-ext.html) 07:29:01 INFO - PROCESS | 25679 | RSS: Main: 248147968 07:29:01 INFO - PROCESS | 25679 | 07:32:03 INFO - PROCESS | 25679 | Cycle 1(1): loaded http://localhost:59767/tests/dromaeo/cssquery-ext.html (next: http://localhost:59767/tests/dromaeo/cssquery-jquery.html) 07:32:04 INFO - PROCESS | 25679 | RSS: Main: 233078784 07:32:04 INFO - PROCESS | 25679 | 07:35:06 INFO - PROCESS | 25679 | Cycle 1(1): loaded http://localhost:59767/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59767/tests/dromaeo/cssquery-mootools.html) 07:35:06 INFO - PROCESS | 25679 | RSS: Main: 170098688 07:35:06 INFO - PROCESS | 25679 | 07:38:08 INFO - PROCESS | 25679 | Cycle 1(1): loaded http://localhost:59767/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59767/tests/dromaeo/cssquery-prototype.html) 07:38:08 INFO - PROCESS | 25679 | RSS: Main: 208326656 07:38:08 INFO - PROCESS | 25679 | 07:41:11 INFO - PROCESS | 25679 | Cycle 1(1): loaded http://localhost:59767/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59767/tests/dromaeo/cssquery-yui.html) 07:41:12 INFO - PROCESS | 25679 | RSS: Main: 174878720 07:41:12 INFO - PROCESS | 25679 | 07:44:14 INFO - PROCESS | 25679 | Cycle 1(1): loaded http://localhost:59767/tests/dromaeo/cssquery-yui.html (next: http://localhost:59767/tests/dromaeo/cssquery-dojo.html) 07:44:15 INFO - PROCESS | 25679 | RSS: Main: 261984256 07:44:15 INFO - PROCESS | 25679 | 07:44:15 INFO - PROCESS | 25679 | __start_tp_report 07:44:15 INFO - PROCESS | 25679 | _x_x_mozilla_page_load 07:44:15 INFO - PROCESS | 25679 | _x_x_mozilla_page_load_details 07:44:15 INFO - PROCESS | 25679 | |i|pagename|runs| 07:44:15 INFO - PROCESS | 25679 | |0;dojo.html;3378.4594464885618;3437.329720704463;3449.7067749241314;3461.948070778937;3499.8775042873503;5665.405132461089;5753.683547404891;5765.5099316558035;5772.163036359725;5783.161441590967;5747.195392645022;5783.566232532567;5795.21764561784;5799.507041901444;5803.071508558632;5118.33461649985;5136.280920671109;5173.224016397533;5174.948250517503;5203.713795741232;4999.975000125012;5007.849764507052;5231.189165679326;5243.79024839006;5243.816466423676;5106.974465127669;5135.512126347991;5203.219517072451;5216.895662086756;5229.8954020919555;5230.137027390476;5231.424543300234;5236.633435659505;5239.502247286483;5271.051210782058;4968.2299243616935;5081.59347252219;5158.097332966753;5210.166373380241;5221.242919776611;5615.101583746581;5616.410276920906;5720.971395143039;5722.885542289131;5726.599138060337;6052.54605904559;6094.451499365078;6098.756049758004;6106.206193194901;6136.846578835565;6110.969445152746;6133.773245350948;6140.662263575501;6180.165677633507;6193.2877719062435;5624.6625202487985;5632.464915832989;5674.886502269973;5739.569532285095;5743.741531631086;6287.371262873768;6290.968545157245;6293.087502312139;6293.527985401113;6294.024426213944;5996.8800623988145;6051.273847138372;6055.7274922628585;6058.1518587397795;6063.636181829104;5942.1383899335215;5984.73068711909;6044.607100538451;6116;6160.476359509402;6129.509639228941;6133.938660613337;6134.467201660849;6137.171481849893;6138.877222455615;5952.9107063394085;5974.790882319098;5976.970115149396;5981.282246130492;6131.468419844907;4558.703684260512;4642.187617166982;4645.163870503342;4646.930296045562;4651.511591282934;4164.437800896901;4169.228692691861;4185.748855068706;4186.246475634415;4188.036751547101;6011.639301641915;6014.127951447016;6021.879562408727;6022.7289771959495;6039.335673075958;5996;6034.064719968412;6141.140240366352;6247.437730604267;6258.3428739982555;5944.227250457413;5952.940470595238;5953.166556682068;5966.880662386728;5982.581219314693;5270.7628156733035;5275.3142091528625;5280.709560974106;5281.023010743025;5290.894182116336;6242.563020588515;6282.685865706788;6464.676766161673;6469.644169570719;6543.378379053982;6100.23747031621;6145.617236122016;6157.53818463626;6158.476529495043;6251.218597675291;6456.54804163704;6458.321876202931;6462.5153113515735;6463.57986730861;6463.741450341934;5839.065749480063;6115.510759139347;6117.510599152146;6119.326874043941;6120.938790612215;6125.387461253839;6129.695011270001;6137.048757442603;6187.876242475215;6245.7189426476825;6047.395260473917;6052.243469566304;6055.091736239599;6092.634441933498;6094.603850749687;6010;6074.51403887679;6076.8784624308155;6079;6085;5806.361300257053;5871.94128058714;5932.940670593412;5996.190514280691;6014.8195554133445;6108.236470441195;6108.926787320877;6112.967398503122;6115.785947491817;6118.607777722487;5749.712514374348;5780.132980053026;5945.048792193228;5956.225690660186;5959.374265702212 07:44:15 INFO - PROCESS | 25679 | |1;ext.html;791.2048391366676;841.6801615386153;865.4936861935768;932.3986029011288;944.5513381143962;30330.84834575827;41201.17597648045;42232.366514502304;42274.78862605683;42388;44422.33366499505;44582.777086114605;44596.10807783842;44656.106877862425;44740.328895066516;7740.303372696456;7905.130435652102;8806.07536208697;8915.821683566357;8929.95535022324;10425.947870260676;10624.521896514636;10653.414062226575;10655.680329590125;10671.253012289142;10631.946840265788;10682.305650132717;10691.518881650305;10700.197485188643;10709.785804283909;10551.947240263788;10558.841617375745;10606.681799546026;10609.31039482435;10610.52252648625;10466.372017678963;10518.263721539495;10522.368657880475;10529.262951593391;10532.15742740579;40673.18653626941;41084;41098.58901410978;41143.1771364574;41232;4299.161663475624;4326.482654239859;4329.610335069828;4434.534373890728;4498.640108791289;29447.411051778843;29660;29823.25441863949;30864.074077777703;31014.689853101405;4317.309230523133;4364.061726728737;4427.048184640318;4476.552344765498;4545.409096817392;214803;216183;216355;216800;218522.90738546365;51223.48776512187;51353.229701554505;51398.22902656463;51420.48579514232;51495.74252128715;53214.20178697323;53285.467145328825;53362.466375336524;53385;53470.46529534655;15408.460703875311;15650.217489125725;15681.13753743555;15748.291326890318;15783.526494205193;12165;12372.381380930918;13709.108907920952;13856.584302470941;13920.443182272798;12866.614001579968;12904.612861614167;12910.61268161938;12997.15518491295;13002.544910928073;5429.484199001167;5439.89925742331;5457.536109430664;5493.752781124859;5551.8889622207325;1027.2347101409498;1027.2398425165325;1030.5723124903232;1032.3496197395593;1034.5809946971488;28272.71727282701;28332.46680531105;28472.28819279493;28644.856775715987;28731.56902646462;1097.2319376436526;1110.6279396402135;1118.4016551145098;1123.1015187849687;1130.496928866663;14104.85895141056;14899.77650335246;14993.850061499244;15200.315985780666;15225.467108651366;305527;305807;306477;307154;307389;53927;53950;53982.730086349315;54022;54083.45916540784;1505.6235941014747;1511.3576729889753;1522.0715363628178;1559.1346802524708;1570.3326086413228;26855.86572067127;27991;28190.43619127647;28749.71250287554;29033.85483072571;36837.81581092077;36850.44724329084;36884;36964.44553331756;37014;275734;277117;277217;277516;277523;28396.858015710615;28935.421291574472;28963.420731585673;29088.41823163567;29128.563071554367;36627.633723663486;36673.26653466969;37171.62828371682;37395;37588;28237;28529.28676783097;28876.566851496824;28929.56605650875;29001;28332.57501137526;28498.715012849607;28936.710632893402;28951.710482895745;29330;32912.34175316528;33060.834695826365;33118.17204569905;33469.16327091842;33850.83074584611;27316.726832732213;27767.86116069407;28035.43929121447;28055.29861753391;28433;19861;19878.60242795107;20015.899920500306;20035.198592056153;20173.293934712216 07:44:15 INFO - PROCESS | 25679 | |2;jquery.html;413.6091393633018;474.3004068998228;479.22604992936397;490.93372394726714;496.87081358846694;18130.3654372097;19248;20294.797052029477;21092.472688182766;21213.151473941063;21243.6813447798;21272;21690;22092.558148837055;22113.115475381004;6455.580387274812;6610.338966103375;6676.2989886062;6710.664466776666;6812.250652428229;6601.50488713346;6680.899786503206;6681.732730690766;6718.798436046926;6724.697388617499;6509.804705858832;6597.2083349998065;6656;6670.199576050856;6729.5625784323865;6396.232452105777;6576.276609572943;6619.271880093186;6672.165979252593;6674.365935236169;6380.138681278015;6416.935830641681;6419.935800642027;6436.90344644826;6439.420452159281;23899.163529276393;23973.88013059941;24077.277681669577;24126;24514.142005029917;3649.9270014599824;3693.5567731872347;3694.408894576855;3743.045523391545;3771.41543060826;15223.467178648694;15765.211739413098;16012.759808602881;16137.838621613751;16324.428644997486;2230.8215342772537;2270.0465804362207;2303.60838657427;2332.521833024226;2340.134150364376;85254;93233.53383233109;93268.53365733195;95032.52483737606;96758.9999999993;14024.4805173097;17540.298388064333;17563.331483509046;17666.470005899842;17674.91162544179;27507.58738618922;28481.145565633065;28548;30969.69030309713;30989.380212395627;9800.068993445611;9983.550740216708;9998.950005249928;10189.23580731448;10290.176785857113;8366.53984030872;8429.28351090152;8463.153684631488;8633.956830215935;8641.438306510057;8838.70193749617;8936.642534298555;9026.954865225633;9111.225545828545;9266;3526.664966828147;3579.534660494119;3600.801955892399;3695.7043436525014;3831.0883728366643;973.5424350555228;975.5024937282037;979.1579241852002;983.9458829764288;987.782687808681;20019.39941801748;20288.391348259574;20332.898335508227;20358.796412035987;20382.898085509478;985.0887928665956;985.7584891701435;988.0958922585753;994.2493417469908;1005.3113617172114;11036.337819730841;11078.501467433985;11183.72040698989;11206.103511719042;11334.489947952361;651594;665782;670564;675202;697368;106449;107395.46302268439;107577.46211268894;107740.46129769301;109472;1241.9009176878528;1256.8428946381703;1262.2237324045645;1272.497363541396;1272.5609664665676;17397.565060873578;17536.210870510604;17882.463526094238;17905.33326049471;18163.909180454015;31455;36651.45022824713;44225.33661995137;45833.312500311855;49694.25458618051;60838.39161608504;62715;62871;62947;64354;11298.661040168809;11429.199956003;11462.541498340306;11635.127365447455;11779.587714429954;12902.80645790295;13018.2839943804;13057.477700891857;13109.410076546388;13406;11086.445677716243;11140.10879129684;11354.545818167511;11817;11840.70398240051;10656.254062215881;10676.252662313564;10850.240483166419;10858.348499089763;11230.94384528072;11368.204225704121;11474.483648235682;11789.351585662871;11865.28808271472;11958.641240762443;10769.676909692722;11514.82727759101;11524.308541487537;11626.88373116258;11747;11112.499937502671;11115.888841111486;11132.833007505056;11338.655096746645;11820.70448238801 07:44:15 INFO - PROCESS | 25679 | |3;mootools.html;1550.2868680407012;1566.670999090191;1572.4260644864628;1591.705534476122;1596.9201539923008;10767.461626918652;11500.539978400875;11512.079033677297;11522.539098436064;11528.308301501917;11421.314721116738;11660.358680272602;11696.941515292412;12065.879341206586;12071.577494787683;2536.7082785479674;2574.11193138367;2574.4207553300453;2574.5108429398447;2574.9613755793584;2454.840435371695;2462.212092130519;2504.5241404133158;2511.183865243794;2512.6356678281636;2432.622943443769;2472.4560596668703;2527.519771243467;2532.126416386344;2533.6326232696247;2413.855168689884;2444.4255599934;2465;2507.2227609441134;2509.7113831909382;2380.4405964598304;2397.077125306752;2402.2192787344006;2405.1101092595677;2410.554047501218;11280.32318060919;11535.538578456935;11540.711482212928;11541.769164616744;11554;5847.8538036549;5981.013132833077;5985.461308482258;5991.880162396771;6003.8198854034445;3563.7861728296384;3570.696490798285;3621.203335266237;3635.1093981974323;3666.5600127984812;1410.0952038800003;1414.900956933015;1418.7446259673254;1422.2604245792234;1434.189682829198;17045.7443138353;17097.743533847002;17213;17258.482245532654;17300.740488892676;4589.816407343736;4773.952260477351;4850.6362022847725;4855.878603034882;4869.245266983623;13249.602511924657;13251.337433128305;13251.801222981663;13262.93368533151;13268.800967985488;6005.219321488266;6009.609375390585;6014.48876845473;6016.42843929826;6028.939710602838;5355.892882142335;5431.864203394946;5474.698891561003;5580.804671836548;5585.1901474286815;4113.280175969194;4199.2441360555395;4274.123804620045;4314.8489802857375;4319.568043195718;1106.5076041161606;1108.4956344863067;1121.61864965912;1129.0910816792561;1136.7669627726295;963.5134257200209;989.5151375825793;998.0967224661692;1000.7898341348252;1024.283001898659;6610.438112760469;6643.833904152339;6718.798436046926;6778.288279730656;6854.588724676535;1051.374432212832;1051.3796859852723;1057.9418132002813;1059.8834128245887;1079.8920107989295;4404.581564751344;4422.491413487426;4423.314386270134;4426.955730442719;4450.087732014929;14212.71574568503;14923.104613723212;14983.925080374529;14987.850121498646;14998.700025999418;12507.874921250672;13002.609921702364;14425.92787036079;14823.555293341216;14922.253887305591;8850.734477965543;9294.302927280482;9540;10856.837147442795;10863.565457381615;6946.131733533309;7010.088688470466;7058.364747172779;7083.150021997393;7153.177384600837;12966.157199781985;12979.740405192033;13005;13151.802722958972;13234.602961911158;13357.265350405822;13411.530596429078;13527.594172174851;13621.25083120438;13664.248466334448;9139.177474027103;9195.816083678155;9252.306077044113;9355.625774968925;9363.110504502061;10905.618303359344;10957.616483423042;11041.44792760375;11054.22620416563;11090.112790976864;8833.779155521164;8941.508217048126;8961.50711710836;9095.909040909772;9099.59051842682;8775.473471591726;8832.779180520538;8853.335999799912;8862.778430539289;8966.775830604027;8506.191911768372;8546.444481108709;8587.797708320715;8670.523121228392;8686.82626347482;6271.717772700331;6273;6323.399277068856;6338.8732225354315;6448.709808058555;6367;6489.837754056186;6518.641474718936;6583.111279977142;6661.233958094881 07:44:15 INFO - PROCESS | 25679 | |4;prototype.html;417.57407444406704;426.7695444459992;435.92807186814156;444.57320971866994;457.7642514105236;5164.147915593927;5191.506806853352;5231.319928409306;5243.659162154467;5293.841184764458;5054.267131265964;5083.288339632454;5104.591632669387;5131.538161565459;5144.56271216947;4283.657307415399;4294.2178995716895;4295.806688699;4300.311950087971;4333.328334108218;4325.885362538967;4329.523752387235;4336.739795612258;4351.390805287262;4381.233284175272;4257.957420425802;4282.850100246492;4313.180495705806;4321.854708502249;4385.386045953569;4298;4314.568543145691;4316.6762492813;4332.653387729006;4333.4799824021;4059.376249500194;4084.6936479764136;4095.4061661059277;4105.527864295615;4118;4804.159272127364;5077.5684066854365;5093.344662984545;5146.253793199965;5196.948030519722;5005.824796132118;5018.422881368653;5025.798968041274;5038.193888977746;5048.596112311006;5428.077226871442;5443.693513556718;5453.427390124019;5481.232627432163;5505.394406615269;4375.620134566107;4520.52534483881;4543.8182472701055;4554.8861278467975;4556.567126123046;5447.291852059207;5492.588055895823;5507.5593952484105;5656.377798442168;5694.487496125327;4589.862304130881;4629.259318509023;4656.974216215957;4662.254039353687;4715.552022557851;4515.390422292949;4663.626909847204;4691.953080469151;4753.572178503882;4756.7145971241835;4889.266610008527;4908.705477671351;4983.934880048816;4995.275685025724;5041;5403.918941215885;5414.3232095988005;5433.918491222635;5438.755256013489;5442.945570544323;1567.3260497985748;1587.8729701624072;1625.2280166920618;1636.5990332368647;1645.6215070533844;1214.5931113077042;1243.5771837575269;1260.766758149727;1264.879836415539;1283.9935800320939;5299.735013249322;5340.546053585489;5363.839084827461;5366.651167674088;5425.83722488326;5533.861653458695;5576.442355764391;5587.497125258747;5625.774969001276;5652.710652185871;5211.843644690665;5444.700541470178;5453.23654688344;5462.863428414242;5503.889922201533;2961.452131355706;2994.2065352681557;2996.3408050228913;3012.70453704909;3022.788404811642;5680.573956953245;5863.501602363762;5928.258967629046;5955.880882382328;5967.92577336075;5717.141429285357;5788.942110578924;5806.477417032487;5809.904017667534;5836.416358364129;5856.535866033491;5872.706364681749;5876.08920617305;5914.7413862019275;5988.251468566429;5392.762003768549;5680.6591604503865;5682.039696304768;5685.857853553694;5696.943030569641;5362.195670649434;5395.622306438511;5508.421615730291;5618.438156184512;5624.775008999594;5839.678817665069;5853.9755542780695;5899.351071382059;5903.586748927705;5910.261217347832;4699.741514216751;4708.882277943078;4723.220668589644;4744.217204161275;4784.186688263073;5500.862478438071;5591.524720398812;5605.075162598288;5621.859453513532;5628.85927851807;5470.8905821882545;5481;5485.162470572243;5495.752691128829;5530.55755539564;5392.487713667196;5498.697571633598;5529.281193444826;5534.889302213853;5545.556355491632;5417.404085550507;5420.430854760193;5476.04169270384;5483.013057649661;5491.505764481216;5468.93739505878;5500.889982200413;5515.917261241005;5530.921470313411;5533.087040638411;5192.585447766806;5322.413528131541;5359.4104648487855;5381.515663590139;5419.34967803866 07:44:15 INFO - PROCESS | 25679 | |5;yui.html;852.8081181734107;881.8809460722805;928.9470270701748;940.9717708468746;943.4386540008693;16307.266173022213;17974.730379044307;18186;18448.07759612021;19086.33197838076;15569.844301556981;15840.76238856418;16540.50378488644;16882.493525194233;17210.913945430286;877.2411863737868;896.6458248991645;899.0874262623443;899.3299991506337;899.9820003599924;905.4657751926362;911.0707078779641;911.9361644684875;915.1534830281996;915.3683958068912;960.3661583354952;961.8124465729186;962.1052421248237;962.5812771444444;962.9807403851919;946.356477595235;951.4957072751419;951.5670369981642;951.7144856543044;952.2382094324547;694.0907411291224;699.6361891816227;699.989500157498;700.6391708270245;701.2076353720314;18627;18678.159482823306;18698.43904682848;19274.22903083875;19467.513312167168;15831.762523562156;15954.521364358972;16017.91991040049;16035.518934431986;16343.918280408521;13410.86589134106;13838.515651952133;13914.165150091027;14001.369938352798;14023.43906243749;4156.314208155651;4160.771157586331;4167.249895018896;4248.426462427564;4278.593533614302;47310.11289935143;52516.73741631306;65357.673211634115;79777.41001654939;93342;12706.872931270755;12839.935800321125;12897.35513224335;12956.416961236768;13121.934390327988;21510.677339839916;21947.561048779255;22004.77995220059;23679.88160059223;23857.642135367983;9016.549172541347;9378.48418336998;9494.240460763122;9508.477033763209;9583.233341332676;5261.5264626183825;5278;5290.259363689087;5344.706041167696;5407.756650950717;3973.4039894016128;4050.8177132029127;4057.4522439470884;4095.3037983542868;4101.589841015874;665.9467242620578;666.5600703535644;705.7141857547701;730.631031329186;737.7417903733758;663.5355251324092;671.358852296056;685.1367277230726;691.8754624167698;706.7385067525049;11636.36000020007;11963.521459141537;11963.64109076729;12118.39408029595;12176.452059657337;854.7093988044095;858.7981824271292;876.9035406105323;882.2853488674194;886.3839631456206;5514.653093761008;5742.13867919807;5753.59724819267;5804.854878627983;5826.592138550261;81522;86292;87532.5623371879;88297;89746;74354.6282268596;76012.23987760051;76771.61614192005;78719.21280787233;79326;67591;69135.3086469139;69791.30208697848;70651;72245.2775472249;10750.247482676137;11068.335899846035;11106.61126860556;11109.11127109813;11431.085513159094;45999.31001035054;46458;46791.53208468008;47280.52719472761;47312;54931.72534137464;55101;55397.7230113863;55695;56288.71855640696;13726.434533060272;13940.58178254654;14041.508547201207;14120.293985300488;14396;14778.113313201242;15006.849931500545;15101.169435681142;15267.312970916113;15890.443834465737;14001;14199.148051116967;14438;14664.926675366554;15129.0166139205;14098.929505352407;14101.365438555085;14420.278986050445;14651.487197948021;14749.631259218606;13471.595852124452;13648;13648.385822637807;13729.656758581115;13766.65583360424;8374.371922105745;8436.746897593082;8442.915570844458;8484.830303394021;8815.823683526422;10624.734381640521;10795;10902.56389744433;10907.236493445384;10995.120390368591 07:44:15 INFO - PROCESS | 25679 | __end_tp_report 07:44:15 INFO - PROCESS | 25679 | __start_cc_report 07:44:15 INFO - PROCESS | 25679 | _x_x_mozilla_cycle_collect,1090 07:44:15 INFO - PROCESS | 25679 | __end_cc_report 07:44:15 INFO - PROCESS | 25679 | __startTimestamp1495032255189__endTimestamp 07:44:15 INFO - PROCESS | 25679 | 07:44:15 INFO - PROCESS | 25679 | ------- Summary: start ------- 07:44:15 INFO - PROCESS | 25679 | Number of tests: 6 07:44:15 INFO - PROCESS | 25679 | 07:44:15 INFO - PROCESS | 25679 | [#0] dojo.html Cycles:165 Average:5711.43 Median:5981.28 stddev:653.10 (10.9%) stddev-sans-first:628.94 07:44:15 INFO - PROCESS | 25679 | Values: 3378.5 3437.3 3449.7 3461.9 3499.9 5665.4 5753.7 5765.5 5772.2 5783.2 5747.2 5783.6 5795.2 5799.5 5803.1 5118.3 5136.3 5173.2 5174.9 5203.7 5000.0 5007.8 5231.2 5243.8 5243.8 5107.0 5135.5 5203.2 5216.9 5229.9 5230.1 5231.4 5236.6 5239.5 5271.1 4968.2 5081.6 5158.1 5210.2 5221.2 5615.1 5616.4 5721.0 5722.9 5726.6 6052.5 6094.5 6098.8 6106.2 6136.8 6111.0 6133.8 6140.7 6180.2 6193.3 5624.7 5632.5 5674.9 5739.6 5743.7 6287.4 6291.0 6293.1 6293.5 6294.0 5996.9 6051.3 6055.7 6058.2 6063.6 5942.1 5984.7 6044.6 6116.0 6160.5 6129.5 6133.9 6134.5 6137.2 6138.9 5952.9 5974.8 5977.0 5981.3 6131.5 4558.7 4642.2 4645.2 4646.9 4651.5 4164.4 4169.2 4185.7 4186.2 4188.0 6011.6 6014.1 6021.9 6022.7 6039.3 5996.0 6034.1 6141.1 6247.4 6258.3 5944.2 5952.9 5953.2 5966.9 5982.6 5270.8 5275.3 5280.7 5281.0 5290.9 6242.6 6282.7 6464.7 6469.6 6543.4 6100.2 6145.6 6157.5 6158.5 6251.2 6456.5 6458.3 6462.5 6463.6 6463.7 5839.1 6115.5 6117.5 6119.3 6120.9 6125.4 6129.7 6137.0 6187.9 6245.7 6047.4 6052.2 6055.1 6092.6 6094.6 6010.0 6074.5 6076.9 6079.0 6085.0 5806.4 5871.9 5932.9 5996.2 6014.8 6108.2 6108.9 6113.0 6115.8 6118.6 5749.7 5780.1 5945.0 5956.2 5959.4 07:44:15 INFO - PROCESS | 25679 | 07:44:15 INFO - PROCESS | 25679 | [#1] ext.html Cycles:180 Average:42746.57 Median:28932.49 stddev:70290.63 (242.9%) stddev-sans-first:70417.23 07:44:15 INFO - PROCESS | 25679 | Values: 791.2 841.7 865.5 932.4 944.6 30330.8 41201.2 42232.4 42274.8 42388.0 44422.3 44582.8 44596.1 44656.1 44740.3 7740.3 7905.1 8806.1 8915.8 8930.0 10425.9 10624.5 10653.4 10655.7 10671.3 10631.9 10682.3 10691.5 10700.2 10709.8 10551.9 10558.8 10606.7 10609.3 10610.5 10466.4 10518.3 10522.4 10529.3 10532.2 40673.2 41084.0 41098.6 41143.2 41232.0 4299.2 4326.5 4329.6 4434.5 4498.6 29447.4 29660.0 29823.3 30864.1 31014.7 4317.3 4364.1 4427.0 4476.6 4545.4 214803.0 216183.0 216355.0 216800.0 218522.9 51223.5 51353.2 51398.2 51420.5 51495.7 53214.2 53285.5 53362.5 53385.0 53470.5 15408.5 15650.2 15681.1 15748.3 15783.5 12165.0 12372.4 13709.1 13856.6 13920.4 12866.6 12904.6 12910.6 12997.2 13002.5 5429.5 5439.9 5457.5 5493.8 5551.9 1027.2 1027.2 1030.6 1032.3 1034.6 28272.7 28332.5 28472.3 28644.9 28731.6 1097.2 1110.6 1118.4 1123.1 1130.5 14104.9 14899.8 14993.9 15200.3 15225.5 305527.0 305807.0 306477.0 307154.0 307389.0 53927.0 53950.0 53982.7 54022.0 54083.5 1505.6 1511.4 1522.1 1559.1 1570.3 26855.9 27991.0 28190.4 28749.7 29033.9 36837.8 36850.4 36884.0 36964.4 37014.0 275734.0 277117.0 277217.0 277516.0 277523.0 28396.9 28935.4 28963.4 29088.4 29128.6 36627.6 36673.3 37171.6 37395.0 37588.0 28237.0 28529.3 28876.6 28929.6 29001.0 28332.6 28498.7 28936.7 28951.7 29330.0 32912.3 33060.8 33118.2 33469.2 33850.8 27316.7 27767.9 28035.4 28055.3 28433.0 19861.0 19878.6 20015.9 20035.2 20173.3 07:44:15 INFO - PROCESS | 25679 | 07:44:15 INFO - PROCESS | 25679 | [#2] jquery.html Cycles:180 Average:36367.71 Median:24101.64 stddev:110283.97 (457.6%) stddev-sans-first:110560.30 07:44:15 INFO - PROCESS | 25679 | Values: 413.6 474.3 479.2 490.9 496.9 18130.4 19248.0 20294.8 21092.5 21213.2 21243.7 21272.0 21690.0 22092.6 22113.1 6455.6 6610.3 6676.3 6710.7 6812.3 6601.5 6680.9 6681.7 6718.8 6724.7 6509.8 6597.2 6656.0 6670.2 6729.6 6396.2 6576.3 6619.3 6672.2 6674.4 6380.1 6416.9 6419.9 6436.9 6439.4 23899.2 23973.9 24077.3 24126.0 24514.1 3649.9 3693.6 3694.4 3743.0 3771.4 15223.5 15765.2 16012.8 16137.8 16324.4 2230.8 2270.0 2303.6 2332.5 2340.1 85254.0 93233.5 93268.5 95032.5 96759.0 14024.5 17540.3 17563.3 17666.5 17674.9 27507.6 28481.1 28548.0 30969.7 30989.4 9800.1 9983.6 9999.0 10189.2 10290.2 8366.5 8429.3 8463.2 8634.0 8641.4 8838.7 8936.6 9027.0 9111.2 9266.0 3526.7 3579.5 3600.8 3695.7 3831.1 973.5 975.5 979.2 983.9 987.8 20019.4 20288.4 20332.9 20358.8 20382.9 985.1 985.8 988.1 994.2 1005.3 11036.3 11078.5 11183.7 11206.1 11334.5 651594.0 665782.0 670564.0 675202.0 697368.0 106449.0 107395.5 107577.5 107740.5 109472.0 1241.9 1256.8 1262.2 1272.5 1272.6 17397.6 17536.2 17882.5 17905.3 18163.9 31455.0 36651.5 44225.3 45833.3 49694.3 60838.4 62715.0 62871.0 62947.0 64354.0 11298.7 11429.2 11462.5 11635.1 11779.6 12902.8 13018.3 13057.5 13109.4 13406.0 11086.4 11140.1 11354.5 11817.0 11840.7 10656.3 10676.3 10850.2 10858.3 11230.9 11368.2 11474.5 11789.4 11865.3 11958.6 10769.7 11514.8 11524.3 11626.9 11747.0 11112.5 11115.9 11132.8 11338.7 11820.7 07:44:15 INFO - PROCESS | 25679 | 07:44:15 INFO - PROCESS | 25679 | [#3] mootools.html Cycles:180 Average:7132.51 Median:2520.08 stddev:4541.89 (180.2%) stddev-sans-first:4535.26 07:44:15 INFO - PROCESS | 25679 | Values: 1550.3 1566.7 1572.4 1591.7 1596.9 10767.5 11500.5 11512.1 11522.5 11528.3 11421.3 11660.4 11696.9 12065.9 12071.6 2536.7 2574.1 2574.4 2574.5 2575.0 2454.8 2462.2 2504.5 2511.2 2512.6 2432.6 2472.5 2527.5 2532.1 2533.6 2413.9 2444.4 2465.0 2507.2 2509.7 2380.4 2397.1 2402.2 2405.1 2410.6 11280.3 11535.5 11540.7 11541.8 11554.0 5847.9 5981.0 5985.5 5991.9 6003.8 3563.8 3570.7 3621.2 3635.1 3666.6 1410.1 1414.9 1418.7 1422.3 1434.2 17045.7 17097.7 17213.0 17258.5 17300.7 4589.8 4774.0 4850.6 4855.9 4869.2 13249.6 13251.3 13251.8 13262.9 13268.8 6005.2 6009.6 6014.5 6016.4 6028.9 5355.9 5431.9 5474.7 5580.8 5585.2 4113.3 4199.2 4274.1 4314.8 4319.6 1106.5 1108.5 1121.6 1129.1 1136.8 963.5 989.5 998.1 1000.8 1024.3 6610.4 6643.8 6718.8 6778.3 6854.6 1051.4 1051.4 1057.9 1059.9 1079.9 4404.6 4422.5 4423.3 4427.0 4450.1 14212.7 14923.1 14983.9 14987.9 14998.7 12507.9 13002.6 14425.9 14823.6 14922.3 8850.7 9294.3 9540.0 10856.8 10863.6 6946.1 7010.1 7058.4 7083.2 7153.2 12966.2 12979.7 13005.0 13151.8 13234.6 13357.3 13411.5 13527.6 13621.3 13664.2 9139.2 9195.8 9252.3 9355.6 9363.1 10905.6 10957.6 11041.4 11054.2 11090.1 8833.8 8941.5 8961.5 9095.9 9099.6 8775.5 8832.8 8853.3 8862.8 8966.8 8506.2 8546.4 8587.8 8670.5 8686.8 6271.7 6273.0 6323.4 6338.9 6448.7 6367.0 6489.8 6518.6 6583.1 6661.2 07:44:15 INFO - PROCESS | 25679 | 07:44:15 INFO - PROCESS | 25679 | [#4] prototype.html Cycles:180 Average:4775.29 Median:5268.75 stddev:1276.77 (24.2%) stddev-sans-first:1237.75 07:44:15 INFO - PROCESS | 25679 | Values: 417.6 426.8 435.9 444.6 457.8 5164.1 5191.5 5231.3 5243.7 5293.8 5054.3 5083.3 5104.6 5131.5 5144.6 4283.7 4294.2 4295.8 4300.3 4333.3 4325.9 4329.5 4336.7 4351.4 4381.2 4258.0 4282.9 4313.2 4321.9 4385.4 4298.0 4314.6 4316.7 4332.7 4333.5 4059.4 4084.7 4095.4 4105.5 4118.0 4804.2 5077.6 5093.3 5146.3 5196.9 5005.8 5018.4 5025.8 5038.2 5048.6 5428.1 5443.7 5453.4 5481.2 5505.4 4375.6 4520.5 4543.8 4554.9 4556.6 5447.3 5492.6 5507.6 5656.4 5694.5 4589.9 4629.3 4657.0 4662.3 4715.6 4515.4 4663.6 4692.0 4753.6 4756.7 4889.3 4908.7 4983.9 4995.3 5041.0 5403.9 5414.3 5433.9 5438.8 5442.9 1567.3 1587.9 1625.2 1636.6 1645.6 1214.6 1243.6 1260.8 1264.9 1284.0 5299.7 5340.5 5363.8 5366.7 5425.8 5533.9 5576.4 5587.5 5625.8 5652.7 5211.8 5444.7 5453.2 5462.9 5503.9 2961.5 2994.2 2996.3 3012.7 3022.8 5680.6 5863.5 5928.3 5955.9 5967.9 5717.1 5788.9 5806.5 5809.9 5836.4 5856.5 5872.7 5876.1 5914.7 5988.3 5392.8 5680.7 5682.0 5685.9 5696.9 5362.2 5395.6 5508.4 5618.4 5624.8 5839.7 5854.0 5899.4 5903.6 5910.3 4699.7 4708.9 4723.2 4744.2 4784.2 5500.9 5591.5 5605.1 5621.9 5628.9 5470.9 5481.0 5485.2 5495.8 5530.6 5392.5 5498.7 5529.3 5534.9 5545.6 5417.4 5420.4 5476.0 5483.0 5491.5 5468.9 5500.9 5515.9 5530.9 5533.1 5192.6 5322.4 5359.4 5381.5 5419.3 07:44:15 INFO - PROCESS | 25679 | 07:44:15 INFO - PROCESS | 25679 | [#5] yui.html Cycles:180 Average:18687.45 Median:49914.37 stddev:23439.01 (47.0%) stddev-sans-first:23466.50 07:44:15 INFO - PROCESS | 25679 | Values: 852.8 881.9 928.9 941.0 943.4 16307.3 17974.7 18186.0 18448.1 19086.3 15569.8 15840.8 16540.5 16882.5 17210.9 877.2 896.6 899.1 899.3 900.0 905.5 911.1 911.9 915.2 915.4 960.4 961.8 962.1 962.6 963.0 946.4 951.5 951.6 951.7 952.2 694.1 699.6 700.0 700.6 701.2 18627.0 18678.2 18698.4 19274.2 19467.5 15831.8 15954.5 16017.9 16035.5 16343.9 13410.9 13838.5 13914.2 14001.4 14023.4 4156.3 4160.8 4167.2 4248.4 4278.6 47310.1 52516.7 65357.7 79777.4 93342.0 12706.9 12839.9 12897.4 12956.4 13121.9 21510.7 21947.6 22004.8 23679.9 23857.6 9016.5 9378.5 9494.2 9508.5 9583.2 5261.5 5278.0 5290.3 5344.7 5407.8 3973.4 4050.8 4057.5 4095.3 4101.6 665.9 666.6 705.7 730.6 737.7 663.5 671.4 685.1 691.9 706.7 11636.4 11963.5 11963.6 12118.4 12176.5 854.7 858.8 876.9 882.3 886.4 5514.7 5742.1 5753.6 5804.9 5826.6 81522.0 86292.0 87532.6 88297.0 89746.0 74354.6 76012.2 76771.6 78719.2 79326.0 67591.0 69135.3 69791.3 70651.0 72245.3 10750.2 11068.3 11106.6 11109.1 11431.1 45999.3 46458.0 46791.5 47280.5 47312.0 54931.7 55101.0 55397.7 55695.0 56288.7 13726.4 13940.6 14041.5 14120.3 14396.0 14778.1 15006.8 15101.2 15267.3 15890.4 14001.0 14199.1 14438.0 14664.9 15129.0 14098.9 14101.4 14420.3 14651.5 14749.6 13471.6 13648.0 13648.4 13729.7 13766.7 8374.4 8436.7 8442.9 8484.8 8815.8 10624.7 10795.0 10902.6 10907.2 10995.1 07:44:15 INFO - PROCESS | 25679 | -------- Summary: end -------- 07:44:15 INFO - PROCESS | 25679 | 07:44:15 INFO - TEST-INFO | 25679: exit 0 07:44:15 INFO - TEST-OK | dromaeo_css | took 1117233ms 07:44:15 INFO - TEST-START | kraken 07:44:15 INFO - operating with platform_type : linux_ 07:44:15 INFO - Initialising browser for kraken test... 07:44:15 INFO - TEST-INFO | started process 25993 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ7RBWG/profile http://localhost:59767/getInfo.html) 07:44:19 INFO - PROCESS | 25993 | __metrics Screen width/height:1600/1200 07:44:19 INFO - PROCESS | 25993 | colorDepth:24 07:44:19 INFO - PROCESS | 25993 | Browser inner width/height: 1024/697 07:44:19 INFO - PROCESS | 25993 | __metrics 07:44:20 INFO - PROCESS | 25993 | 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:44:20 INFO - PROCESS | 25993 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:44:21 INFO - PROCESS | 25993 | console.error: PushService: 07:44:21 INFO - PROCESS | 25993 | stateChangeProcessEnqueue: Error transitioning state 07:44:21 INFO - PROCESS | 25993 | UnknownError 07:44:21 INFO - TEST-INFO | 25993: exit 0 07:44:21 INFO - Browser initialized. 07:44:21 INFO - Running cycle 1/1 for kraken test... 07:44:21 INFO - TEST-INFO | started process 26085 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ7RBWG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:44:33 INFO - PROCESS | 26085 | RSS: Main: 141447168 07:44:33 INFO - PROCESS | 26085 | 07:44:36 INFO - PROCESS | 26085 | Cycle 1(1): loaded http://localhost:59767/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59767/tests/kraken/driver.html?testName=audio-beat-detection) 07:44:36 INFO - PROCESS | 26085 | RSS: Main: 184168448 07:44:36 INFO - PROCESS | 26085 | 07:44:39 INFO - PROCESS | 26085 | Cycle 1(1): loaded http://localhost:59767/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59767/tests/kraken/driver.html?testName=audio-dft) 07:44:39 INFO - PROCESS | 26085 | RSS: Main: 173752320 07:44:39 INFO - PROCESS | 26085 | 07:44:42 INFO - PROCESS | 26085 | Cycle 1(1): loaded http://localhost:59767/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59767/tests/kraken/driver.html?testName=audio-fft) 07:44:43 INFO - PROCESS | 26085 | RSS: Main: 265584640 07:44:43 INFO - PROCESS | 26085 | 07:44:45 INFO - PROCESS | 26085 | Cycle 1(1): loaded http://localhost:59767/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59767/tests/kraken/driver.html?testName=audio-oscillator) 07:44:46 INFO - PROCESS | 26085 | RSS: Main: 171474944 07:44:46 INFO - PROCESS | 26085 | 07:44:48 INFO - PROCESS | 26085 | Cycle 1(1): loaded http://localhost:59767/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59767/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:44:48 INFO - PROCESS | 26085 | RSS: Main: 173953024 07:44:48 INFO - PROCESS | 26085 | 07:44:51 INFO - PROCESS | 26085 | Cycle 1(1): loaded http://localhost:59767/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59767/tests/kraken/driver.html?testName=imaging-darkroom) 07:44:52 INFO - PROCESS | 26085 | RSS: Main: 212758528 07:44:52 INFO - PROCESS | 26085 | 07:44:55 INFO - PROCESS | 26085 | Cycle 1(1): loaded http://localhost:59767/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59767/tests/kraken/driver.html?testName=imaging-desaturate) 07:44:56 INFO - PROCESS | 26085 | RSS: Main: 212987904 07:44:56 INFO - PROCESS | 26085 | 07:44:59 INFO - PROCESS | 26085 | Cycle 1(1): loaded http://localhost:59767/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59767/tests/kraken/driver.html?testName=json-parse-financial) 07:44:59 INFO - PROCESS | 26085 | RSS: Main: 211578880 07:44:59 INFO - PROCESS | 26085 | 07:45:01 INFO - PROCESS | 26085 | Cycle 1(1): loaded http://localhost:59767/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59767/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:45:01 INFO - PROCESS | 26085 | RSS: Main: 174030848 07:45:01 INFO - PROCESS | 26085 | 07:45:03 INFO - PROCESS | 26085 | Cycle 1(1): loaded http://localhost:59767/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59767/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:45:04 INFO - PROCESS | 26085 | RSS: Main: 179965952 07:45:04 INFO - PROCESS | 26085 | 07:45:06 INFO - PROCESS | 26085 | Cycle 1(1): loaded http://localhost:59767/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59767/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:45:06 INFO - PROCESS | 26085 | RSS: Main: 190337024 07:45:06 INFO - PROCESS | 26085 | 07:45:09 INFO - PROCESS | 26085 | Cycle 1(1): loaded http://localhost:59767/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59767/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:45:09 INFO - PROCESS | 26085 | RSS: Main: 198594560 07:45:09 INFO - PROCESS | 26085 | 07:45:12 INFO - PROCESS | 26085 | Cycle 1(1): loaded http://localhost:59767/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59767/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:45:13 INFO - PROCESS | 26085 | RSS: Main: 196198400 07:45:13 INFO - PROCESS | 26085 | 07:45:14 INFO - PROCESS | 26085 | Cycle 1(1): loaded http://localhost:59767/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59767/tests/kraken/driver.html?testName=ai-astar) 07:45:15 INFO - PROCESS | 26085 | RSS: Main: 246718464 07:45:15 INFO - PROCESS | 26085 | 07:45:15 INFO - PROCESS | 26085 | __start_tp_report 07:45:15 INFO - PROCESS | 26085 | _x_x_mozilla_page_load 07:45:15 INFO - PROCESS | 26085 | _x_x_mozilla_page_load_details 07:45:15 INFO - PROCESS | 26085 | |i|pagename|runs| 07:45:15 INFO - PROCESS | 26085 | |0;ai-astar;105;114;113;113;113;114;112;112;113;112 07:45:15 INFO - PROCESS | 26085 | |1;audio-beat-detection;145;116;117;157;122;117;118;116;132;117 07:45:15 INFO - PROCESS | 26085 | |2;audio-dft;162;163;163;164;161;159;163;162;161;159 07:45:15 INFO - PROCESS | 26085 | |3;audio-fft;76;75;76;105;76;76;77;86;91;76 07:45:15 INFO - PROCESS | 26085 | |4;audio-oscillator;82;82;115;82;83;83;97;82;82;100 07:45:15 INFO - PROCESS | 26085 | |5;imaging-gaussian-blur;113;113;113;113;113;113;113;114;113;113 07:45:15 INFO - PROCESS | 26085 | |6;imaging-darkroom;147;147;147;147;147;147;147;147;147;146 07:45:15 INFO - PROCESS | 26085 | |7;imaging-desaturate;95;94;94;93;93;93;93;94;94;93 07:45:15 INFO - PROCESS | 26085 | |8;json-parse-financial;57;55;58;56;55;56;59;59;56;55 07:45:15 INFO - PROCESS | 26085 | |9;json-stringify-tinderbox;52;54;55;54;53;56;53;53;53;53 07:45:15 INFO - PROCESS | 26085 | |10;stanford-crypto-aes;76;81;77;80;76;85;79;78;80;77 07:45:15 INFO - PROCESS | 26085 | |11;stanford-crypto-ccm;124;124;131;121;135;118;122;119;165;132 07:45:15 INFO - PROCESS | 26085 | |12;stanford-crypto-pbkdf2;160;159;163;159;157;158;161;163;161;159 07:45:15 INFO - PROCESS | 26085 | |13;stanford-crypto-sha256-iterative;63;61;60;60;60;59;60;60;60;60 07:45:15 INFO - PROCESS | 26085 | __end_tp_report 07:45:15 INFO - PROCESS | 26085 | __start_cc_report 07:45:15 INFO - PROCESS | 26085 | _x_x_mozilla_cycle_collect,1650 07:45:15 INFO - PROCESS | 26085 | __end_cc_report 07:45:15 INFO - PROCESS | 26085 | __startTimestamp1495032315069__endTimestamp 07:45:15 INFO - PROCESS | 26085 | 07:45:15 INFO - PROCESS | 26085 | ------- Summary: start ------- 07:45:15 INFO - PROCESS | 26085 | Number of tests: 14 07:45:15 INFO - PROCESS | 26085 | 07:45:15 INFO - PROCESS | 26085 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.00 stddev:2.60 (2.3%) stddev-sans-first:0.78 07:45:15 INFO - PROCESS | 26085 | Values: 105.0 114.0 113.0 113.0 113.0 114.0 112.0 112.0 113.0 112.0 07:45:15 INFO - PROCESS | 26085 | 07:45:15 INFO - PROCESS | 26085 | [#1] audio-beat-detection Cycles:10 Average:125.70 Median:120.00 stddev:14.45 (12.0%) stddev-sans-first:13.54 07:45:15 INFO - PROCESS | 26085 | Values: 145.0 116.0 117.0 157.0 122.0 117.0 118.0 116.0 132.0 117.0 07:45:15 INFO - PROCESS | 26085 | 07:45:15 INFO - PROCESS | 26085 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.50 stddev:1.70 (1.0%) stddev-sans-first:1.80 07:45:15 INFO - PROCESS | 26085 | Values: 162.0 163.0 163.0 164.0 161.0 159.0 163.0 162.0 161.0 159.0 07:45:15 INFO - PROCESS | 26085 | 07:45:15 INFO - PROCESS | 26085 | [#3] audio-fft Cycles:10 Average:81.40 Median:76.00 stddev:9.87 (13.0%) stddev-sans-first:10.27 07:45:15 INFO - PROCESS | 26085 | Values: 76.0 75.0 76.0 105.0 76.0 76.0 77.0 86.0 91.0 76.0 07:45:15 INFO - PROCESS | 26085 | 07:45:15 INFO - PROCESS | 26085 | [#4] audio-oscillator Cycles:10 Average:88.80 Median:82.00 stddev:11.44 (13.9%) stddev-sans-first:11.86 07:45:15 INFO - PROCESS | 26085 | Values: 82.0 82.0 115.0 82.0 83.0 83.0 97.0 82.0 82.0 100.0 07:45:15 INFO - PROCESS | 26085 | 07:45:15 INFO - PROCESS | 26085 | [#5] imaging-gaussian-blur Cycles:10 Average:113.10 Median:113.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:45:15 INFO - PROCESS | 26085 | Values: 113.0 113.0 113.0 113.0 113.0 113.0 113.0 114.0 113.0 113.0 07:45:15 INFO - PROCESS | 26085 | 07:45:15 INFO - PROCESS | 26085 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 07:45:15 INFO - PROCESS | 26085 | Values: 147.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 146.0 07:45:15 INFO - PROCESS | 26085 | 07:45:15 INFO - PROCESS | 26085 | [#7] imaging-desaturate Cycles:10 Average:93.60 Median:94.00 stddev:0.70 (0.7%) stddev-sans-first:0.53 07:45:15 INFO - PROCESS | 26085 | Values: 95.0 94.0 94.0 93.0 93.0 93.0 93.0 94.0 94.0 93.0 07:45:15 INFO - PROCESS | 26085 | 07:45:15 INFO - PROCESS | 26085 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:56.50 stddev:1.58 (2.8%) stddev-sans-first:1.67 07:45:15 INFO - PROCESS | 26085 | Values: 57.0 55.0 58.0 56.0 55.0 56.0 59.0 59.0 56.0 55.0 07:45:15 INFO - PROCESS | 26085 | 07:45:15 INFO - PROCESS | 26085 | [#9] json-stringify-tinderbox Cycles:10 Average:53.60 Median:53.50 stddev:1.17 (2.2%) stddev-sans-first:1.09 07:45:15 INFO - PROCESS | 26085 | Values: 52.0 54.0 55.0 54.0 53.0 56.0 53.0 53.0 53.0 53.0 07:45:15 INFO - PROCESS | 26085 | 07:45:15 INFO - PROCESS | 26085 | [#10] stanford-crypto-aes Cycles:10 Average:78.90 Median:79.50 stddev:2.77 (3.5%) stddev-sans-first:2.73 07:45:15 INFO - PROCESS | 26085 | Values: 76.0 81.0 77.0 80.0 76.0 85.0 79.0 78.0 80.0 77.0 07:45:15 INFO - PROCESS | 26085 | 07:45:15 INFO - PROCESS | 26085 | [#11] stanford-crypto-ccm Cycles:10 Average:129.10 Median:127.50 stddev:13.86 (10.9%) stddev-sans-first:14.58 07:45:15 INFO - PROCESS | 26085 | Values: 124.0 124.0 131.0 121.0 135.0 118.0 122.0 119.0 165.0 132.0 07:45:15 INFO - PROCESS | 26085 | 07:45:15 INFO - PROCESS | 26085 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.00 Median:160.50 stddev:2.00 (1.2%) stddev-sans-first:2.12 07:45:15 INFO - PROCESS | 26085 | Values: 160.0 159.0 163.0 159.0 157.0 158.0 161.0 163.0 161.0 159.0 07:45:15 INFO - PROCESS | 26085 | 07:45:15 INFO - PROCESS | 26085 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.30 Median:60.00 stddev:1.06 (1.8%) stddev-sans-first:0.50 07:45:15 INFO - PROCESS | 26085 | Values: 63.0 61.0 60.0 60.0 60.0 59.0 60.0 60.0 60.0 60.0 07:45:15 INFO - PROCESS | 26085 | -------- Summary: end -------- 07:45:15 INFO - PROCESS | 26085 | 07:45:16 INFO - TEST-INFO | 26085: exit 0 07:45:16 INFO - TEST-OK | kraken | took 60286ms 07:45:16 INFO - SUITE-END | took 1177s 07:45:16 INFO - Completed test suite (00:19:38) 07:45:16 INFO - javascript benchmark 07:45:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7730.973515606345, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3378.4594464885618, 3437.329720704463, 3449.7067749241314, 3461.948070778937, 3499.8775042873503, 5665.405132461089, 5753.683547404891, 5765.5099316558035, 5772.163036359725, 5783.161441590967, 5747.195392645022, 5783.566232532567, 5795.21764561784, 5799.507041901444, 5803.071508558632, 5118.33461649985, 5136.280920671109, 5173.224016397533, 5174.948250517503, 5203.713795741232, 4999.975000125012, 5007.849764507052, 5231.189165679326, 5243.79024839006, 5243.816466423676, 5106.974465127669, 5135.512126347991, 5203.219517072451, 5216.895662086756, 5229.8954020919555, 5230.137027390476, 5231.424543300234, 5236.633435659505, 5239.502247286483, 5271.051210782058, 4968.2299243616935, 5081.59347252219, 5158.097332966753, 5210.166373380241, 5221.242919776611, 5615.101583746581, 5616.410276920906, 5720.971395143039, 5722.885542289131, 5726.599138060337, 6052.54605904559, 6094.451499365078, 6098.756049758004, 6106.206193194901, 6136.846578835565, 6110.969445152746, 6133.773245350948, 6140.662263575501, 6180.165677633507, 6193.2877719062435, 5624.6625202487985, 5632.464915832989, 5674.886502269973, 5739.569532285095, 5743.741531631086, 6287.371262873768, 6290.968545157245, 6293.087502312139, 6293.527985401113, 6294.024426213944, 5996.8800623988145, 6051.273847138372, 6055.7274922628585, 6058.1518587397795, 6063.636181829104, 5942.1383899335215, 5984.73068711909, 6044.607100538451, 6116.0, 6160.476359509402, 6129.509639228941, 6133.938660613337, 6134.467201660849, 6137.171481849893, 6138.877222455615, 5952.9107063394085, 5974.790882319098, 5976.970115149396, 5981.282246130492, 6131.468419844907, 4558.703684260512, 4642.187617166982, 4645.163870503342, 4646.930296045562, 4651.511591282934, 4164.437800896901, 4169.228692691861, 4185.748855068706, 4186.246475634415, 4188.036751547101, 6011.639301641915, 6014.127951447016, 6021.879562408727, 6022.7289771959495, 6039.335673075958, 5996.0, 6034.064719968412, 6141.140240366352, 6247.437730604267, 6258.3428739982555, 5944.227250457413, 5952.940470595238, 5953.166556682068, 5966.880662386728, 5982.581219314693, 5270.7628156733035, 5275.3142091528625, 5280.709560974106, 5281.023010743025, 5290.894182116336, 6242.563020588515, 6282.685865706788, 6464.676766161673, 6469.644169570719, 6543.378379053982, 6100.23747031621, 6145.617236122016, 6157.53818463626, 6158.476529495043, 6251.218597675291, 6456.54804163704, 6458.321876202931, 6462.5153113515735, 6463.57986730861, 6463.741450341934, 5839.065749480063, 6115.510759139347, 6117.510599152146, 6119.326874043941, 6120.938790612215, 6125.387461253839, 6129.695011270001, 6137.048757442603, 6187.876242475215, 6245.7189426476825, 6047.395260473917, 6052.243469566304, 6055.091736239599, 6092.634441933498, 6094.603850749687, 6010.0, 6074.51403887679, 6076.8784624308155, 6079.0, 6085.0, 5806.361300257053, 5871.94128058714, 5932.940670593412, 5996.190514280691, 6014.8195554133445, 6108.236470441195, 6108.926787320877, 6112.967398503122, 6115.785947491817, 6118.607777722487, 5749.712514374348, 5780.132980053026, 5945.048792193228, 5956.225690660186, 5959.374265702212], "value": 5667.946187569854, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [791.2048391366676, 841.6801615386153, 865.4936861935768, 932.3986029011288, 944.5513381143962, 30330.84834575827, 41201.17597648045, 42232.366514502304, 42274.78862605683, 42388.0, 44422.33366499505, 44582.777086114605, 44596.10807783842, 44656.106877862425, 44740.328895066516, 7740.303372696456, 7905.130435652102, 8806.07536208697, 8915.821683566357, 8929.95535022324, 10425.947870260676, 10624.521896514636, 10653.414062226575, 10655.680329590125, 10671.253012289142, 10631.946840265788, 10682.305650132717, 10691.518881650305, 10700.197485188643, 10709.785804283909, 10551.947240263788, 10558.841617375745, 10606.681799546026, 10609.31039482435, 10610.52252648625, 10466.372017678963, 10518.263721539495, 10522.368657880475, 10529.262951593391, 10532.15742740579, 40673.18653626941, 41084.0, 41098.58901410978, 41143.1771364574, 41232.0, 4299.161663475624, 4326.482654239859, 4329.610335069828, 4434.534373890728, 4498.640108791289, 29447.411051778843, 29660.0, 29823.25441863949, 30864.074077777703, 31014.689853101405, 4317.309230523133, 4364.061726728737, 4427.048184640318, 4476.552344765498, 4545.409096817392, 214803.0, 216183.0, 216355.0, 216800.0, 218522.90738546365, 51223.48776512187, 51353.229701554505, 51398.22902656463, 51420.48579514232, 51495.74252128715, 53214.20178697323, 53285.467145328825, 53362.466375336524, 53385.0, 53470.46529534655, 15408.460703875311, 15650.217489125725, 15681.13753743555, 15748.291326890318, 15783.526494205193, 12165.0, 12372.381380930918, 13709.108907920952, 13856.584302470941, 13920.443182272798, 12866.614001579968, 12904.612861614167, 12910.61268161938, 12997.15518491295, 13002.544910928073, 5429.484199001167, 5439.89925742331, 5457.536109430664, 5493.752781124859, 5551.8889622207325, 1027.2347101409498, 1027.2398425165325, 1030.5723124903232, 1032.3496197395593, 1034.5809946971488, 28272.71727282701, 28332.46680531105, 28472.28819279493, 28644.856775715987, 28731.56902646462, 1097.2319376436526, 1110.6279396402135, 1118.4016551145098, 1123.1015187849687, 1130.496928866663, 14104.85895141056, 14899.77650335246, 14993.850061499244, 15200.315985780666, 15225.467108651366, 305527.0, 305807.0, 306477.0, 307154.0, 307389.0, 53927.0, 53950.0, 53982.730086349315, 54022.0, 54083.45916540784, 1505.6235941014747, 1511.3576729889753, 1522.0715363628178, 1559.1346802524708, 1570.3326086413228, 26855.86572067127, 27991.0, 28190.43619127647, 28749.71250287554, 29033.85483072571, 36837.81581092077, 36850.44724329084, 36884.0, 36964.44553331756, 37014.0, 275734.0, 277117.0, 277217.0, 277516.0, 277523.0, 28396.858015710615, 28935.421291574472, 28963.420731585673, 29088.41823163567, 29128.563071554367, 36627.633723663486, 36673.26653466969, 37171.62828371682, 37395.0, 37588.0, 28237.0, 28529.28676783097, 28876.566851496824, 28929.56605650875, 29001.0, 28332.57501137526, 28498.715012849607, 28936.710632893402, 28951.710482895745, 29330.0, 32912.34175316528, 33060.834695826365, 33118.17204569905, 33469.16327091842, 33850.83074584611, 27316.726832732213, 27767.86116069407, 28035.43929121447, 28055.29861753391, 28433.0, 19861.0, 19878.60242795107, 20015.899920500306, 20035.198592056153, 20173.293934712216], "value": 18135.920099781953, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.6091393633018, 474.3004068998228, 479.22604992936397, 490.93372394726714, 496.87081358846694, 18130.3654372097, 19248.0, 20294.797052029477, 21092.472688182766, 21213.151473941063, 21243.6813447798, 21272.0, 21690.0, 22092.558148837055, 22113.115475381004, 6455.580387274812, 6610.338966103375, 6676.2989886062, 6710.664466776666, 6812.250652428229, 6601.50488713346, 6680.899786503206, 6681.732730690766, 6718.798436046926, 6724.697388617499, 6509.804705858832, 6597.2083349998065, 6656.0, 6670.199576050856, 6729.5625784323865, 6396.232452105777, 6576.276609572943, 6619.271880093186, 6672.165979252593, 6674.365935236169, 6380.138681278015, 6416.935830641681, 6419.935800642027, 6436.90344644826, 6439.420452159281, 23899.163529276393, 23973.88013059941, 24077.277681669577, 24126.0, 24514.142005029917, 3649.9270014599824, 3693.5567731872347, 3694.408894576855, 3743.045523391545, 3771.41543060826, 15223.467178648694, 15765.211739413098, 16012.759808602881, 16137.838621613751, 16324.428644997486, 2230.8215342772537, 2270.0465804362207, 2303.60838657427, 2332.521833024226, 2340.134150364376, 85254.0, 93233.53383233109, 93268.53365733195, 95032.52483737606, 96758.9999999993, 14024.4805173097, 17540.298388064333, 17563.331483509046, 17666.470005899842, 17674.91162544179, 27507.58738618922, 28481.145565633065, 28548.0, 30969.69030309713, 30989.380212395627, 9800.068993445611, 9983.550740216708, 9998.950005249928, 10189.23580731448, 10290.176785857113, 8366.53984030872, 8429.28351090152, 8463.153684631488, 8633.956830215935, 8641.438306510057, 8838.70193749617, 8936.642534298555, 9026.954865225633, 9111.225545828545, 9266.0, 3526.664966828147, 3579.534660494119, 3600.801955892399, 3695.7043436525014, 3831.0883728366643, 973.5424350555228, 975.5024937282037, 979.1579241852002, 983.9458829764288, 987.782687808681, 20019.39941801748, 20288.391348259574, 20332.898335508227, 20358.796412035987, 20382.898085509478, 985.0887928665956, 985.7584891701435, 988.0958922585753, 994.2493417469908, 1005.3113617172114, 11036.337819730841, 11078.501467433985, 11183.72040698989, 11206.103511719042, 11334.489947952361, 651594.0, 665782.0, 670564.0, 675202.0, 697368.0, 106449.0, 107395.46302268439, 107577.46211268894, 107740.46129769301, 109472.0, 1241.9009176878528, 1256.8428946381703, 1262.2237324045645, 1272.497363541396, 1272.5609664665676, 17397.565060873578, 17536.210870510604, 17882.463526094238, 17905.33326049471, 18163.909180454015, 31455.0, 36651.45022824713, 44225.33661995137, 45833.312500311855, 49694.25458618051, 60838.39161608504, 62715.0, 62871.0, 62947.0, 64354.0, 11298.661040168809, 11429.199956003, 11462.541498340306, 11635.127365447455, 11779.587714429954, 12902.80645790295, 13018.2839943804, 13057.477700891857, 13109.410076546388, 13406.0, 11086.445677716243, 11140.10879129684, 11354.545818167511, 11817.0, 11840.70398240051, 10656.254062215881, 10676.252662313564, 10850.240483166419, 10858.348499089763, 11230.94384528072, 11368.204225704121, 11474.483648235682, 11789.351585662871, 11865.28808271472, 11958.641240762443, 10769.676909692722, 11514.82727759101, 11524.308541487537, 11626.88373116258, 11747.0, 11112.499937502671, 11115.888841111486, 11132.833007505056, 11338.655096746645, 11820.70448238801], "value": 10975.427800733301, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1550.2868680407012, 1566.670999090191, 1572.4260644864628, 1591.705534476122, 1596.9201539923008, 10767.461626918652, 11500.539978400875, 11512.079033677297, 11522.539098436064, 11528.308301501917, 11421.314721116738, 11660.358680272602, 11696.941515292412, 12065.879341206586, 12071.577494787683, 2536.7082785479674, 2574.11193138367, 2574.4207553300453, 2574.5108429398447, 2574.9613755793584, 2454.840435371695, 2462.212092130519, 2504.5241404133158, 2511.183865243794, 2512.6356678281636, 2432.622943443769, 2472.4560596668703, 2527.519771243467, 2532.126416386344, 2533.6326232696247, 2413.855168689884, 2444.4255599934, 2465.0, 2507.2227609441134, 2509.7113831909382, 2380.4405964598304, 2397.077125306752, 2402.2192787344006, 2405.1101092595677, 2410.554047501218, 11280.32318060919, 11535.538578456935, 11540.711482212928, 11541.769164616744, 11554.0, 5847.8538036549, 5981.013132833077, 5985.461308482258, 5991.880162396771, 6003.8198854034445, 3563.7861728296384, 3570.696490798285, 3621.203335266237, 3635.1093981974323, 3666.5600127984812, 1410.0952038800003, 1414.900956933015, 1418.7446259673254, 1422.2604245792234, 1434.189682829198, 17045.7443138353, 17097.743533847002, 17213.0, 17258.482245532654, 17300.740488892676, 4589.816407343736, 4773.952260477351, 4850.6362022847725, 4855.878603034882, 4869.245266983623, 13249.602511924657, 13251.337433128305, 13251.801222981663, 13262.93368533151, 13268.800967985488, 6005.219321488266, 6009.609375390585, 6014.48876845473, 6016.42843929826, 6028.939710602838, 5355.892882142335, 5431.864203394946, 5474.698891561003, 5580.804671836548, 5585.1901474286815, 4113.280175969194, 4199.2441360555395, 4274.123804620045, 4314.8489802857375, 4319.568043195718, 1106.5076041161606, 1108.4956344863067, 1121.61864965912, 1129.0910816792561, 1136.7669627726295, 963.5134257200209, 989.5151375825793, 998.0967224661692, 1000.7898341348252, 1024.283001898659, 6610.438112760469, 6643.833904152339, 6718.798436046926, 6778.288279730656, 6854.588724676535, 1051.374432212832, 1051.3796859852723, 1057.9418132002813, 1059.8834128245887, 1079.8920107989295, 4404.581564751344, 4422.491413487426, 4423.314386270134, 4426.955730442719, 4450.087732014929, 14212.71574568503, 14923.104613723212, 14983.925080374529, 14987.850121498646, 14998.700025999418, 12507.874921250672, 13002.609921702364, 14425.92787036079, 14823.555293341216, 14922.253887305591, 8850.734477965543, 9294.302927280482, 9540.0, 10856.837147442795, 10863.565457381615, 6946.131733533309, 7010.088688470466, 7058.364747172779, 7083.150021997393, 7153.177384600837, 12966.157199781985, 12979.740405192033, 13005.0, 13151.802722958972, 13234.602961911158, 13357.265350405822, 13411.530596429078, 13527.594172174851, 13621.25083120438, 13664.248466334448, 9139.177474027103, 9195.816083678155, 9252.306077044113, 9355.625774968925, 9363.110504502061, 10905.618303359344, 10957.616483423042, 11041.44792760375, 11054.22620416563, 11090.112790976864, 8833.779155521164, 8941.508217048126, 8961.50711710836, 9095.909040909772, 9099.59051842682, 8775.473471591726, 8832.779180520538, 8853.335999799912, 8862.778430539289, 8966.775830604027, 8506.191911768372, 8546.444481108709, 8587.797708320715, 8670.523121228392, 8686.82626347482, 6271.717772700331, 6273.0, 6323.399277068856, 6338.8732225354315, 6448.709808058555, 6367.0, 6489.837754056186, 6518.641474718936, 6583.111279977142, 6661.233958094881], "value": 5426.266074414021, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.57407444406704, 426.7695444459992, 435.92807186814156, 444.57320971866994, 457.7642514105236, 5164.147915593927, 5191.506806853352, 5231.319928409306, 5243.659162154467, 5293.841184764458, 5054.267131265964, 5083.288339632454, 5104.591632669387, 5131.538161565459, 5144.56271216947, 4283.657307415399, 4294.2178995716895, 4295.806688699, 4300.311950087971, 4333.328334108218, 4325.885362538967, 4329.523752387235, 4336.739795612258, 4351.390805287262, 4381.233284175272, 4257.957420425802, 4282.850100246492, 4313.180495705806, 4321.854708502249, 4385.386045953569, 4298.0, 4314.568543145691, 4316.6762492813, 4332.653387729006, 4333.4799824021, 4059.376249500194, 4084.6936479764136, 4095.4061661059277, 4105.527864295615, 4118.0, 4804.159272127364, 5077.5684066854365, 5093.344662984545, 5146.253793199965, 5196.948030519722, 5005.824796132118, 5018.422881368653, 5025.798968041274, 5038.193888977746, 5048.596112311006, 5428.077226871442, 5443.693513556718, 5453.427390124019, 5481.232627432163, 5505.394406615269, 4375.620134566107, 4520.52534483881, 4543.8182472701055, 4554.8861278467975, 4556.567126123046, 5447.291852059207, 5492.588055895823, 5507.5593952484105, 5656.377798442168, 5694.487496125327, 4589.862304130881, 4629.259318509023, 4656.974216215957, 4662.254039353687, 4715.552022557851, 4515.390422292949, 4663.626909847204, 4691.953080469151, 4753.572178503882, 4756.7145971241835, 4889.266610008527, 4908.705477671351, 4983.934880048816, 4995.275685025724, 5041.0, 5403.918941215885, 5414.3232095988005, 5433.918491222635, 5438.755256013489, 5442.945570544323, 1567.3260497985748, 1587.8729701624072, 1625.2280166920618, 1636.5990332368647, 1645.6215070533844, 1214.5931113077042, 1243.5771837575269, 1260.766758149727, 1264.879836415539, 1283.9935800320939, 5299.735013249322, 5340.546053585489, 5363.839084827461, 5366.651167674088, 5425.83722488326, 5533.861653458695, 5576.442355764391, 5587.497125258747, 5625.774969001276, 5652.710652185871, 5211.843644690665, 5444.700541470178, 5453.23654688344, 5462.863428414242, 5503.889922201533, 2961.452131355706, 2994.2065352681557, 2996.3408050228913, 3012.70453704909, 3022.788404811642, 5680.573956953245, 5863.501602363762, 5928.258967629046, 5955.880882382328, 5967.92577336075, 5717.141429285357, 5788.942110578924, 5806.477417032487, 5809.904017667534, 5836.416358364129, 5856.535866033491, 5872.706364681749, 5876.08920617305, 5914.7413862019275, 5988.251468566429, 5392.762003768549, 5680.6591604503865, 5682.039696304768, 5685.857853553694, 5696.943030569641, 5362.195670649434, 5395.622306438511, 5508.421615730291, 5618.438156184512, 5624.775008999594, 5839.678817665069, 5853.9755542780695, 5899.351071382059, 5903.586748927705, 5910.261217347832, 4699.741514216751, 4708.882277943078, 4723.220668589644, 4744.217204161275, 4784.186688263073, 5500.862478438071, 5591.524720398812, 5605.075162598288, 5621.859453513532, 5628.85927851807, 5470.8905821882545, 5481.0, 5485.162470572243, 5495.752691128829, 5530.55755539564, 5392.487713667196, 5498.697571633598, 5529.281193444826, 5534.889302213853, 5545.556355491632, 5417.404085550507, 5420.430854760193, 5476.04169270384, 5483.013057649661, 5491.505764481216, 5468.93739505878, 5500.889982200413, 5515.917261241005, 5530.921470313411, 5533.087040638411, 5192.585447766806, 5322.413528131541, 5359.4104648487855, 5381.515663590139, 5419.34967803866], "value": 4408.667223950213, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [852.8081181734107, 881.8809460722805, 928.9470270701748, 940.9717708468746, 943.4386540008693, 16307.266173022213, 17974.730379044307, 18186.0, 18448.07759612021, 19086.33197838076, 15569.844301556981, 15840.76238856418, 16540.50378488644, 16882.493525194233, 17210.913945430286, 877.2411863737868, 896.6458248991645, 899.0874262623443, 899.3299991506337, 899.9820003599924, 905.4657751926362, 911.0707078779641, 911.9361644684875, 915.1534830281996, 915.3683958068912, 960.3661583354952, 961.8124465729186, 962.1052421248237, 962.5812771444444, 962.9807403851919, 946.356477595235, 951.4957072751419, 951.5670369981642, 951.7144856543044, 952.2382094324547, 694.0907411291224, 699.6361891816227, 699.989500157498, 700.6391708270245, 701.2076353720314, 18627.0, 18678.159482823306, 18698.43904682848, 19274.22903083875, 19467.513312167168, 15831.762523562156, 15954.521364358972, 16017.91991040049, 16035.518934431986, 16343.918280408521, 13410.86589134106, 13838.515651952133, 13914.165150091027, 14001.369938352798, 14023.43906243749, 4156.314208155651, 4160.771157586331, 4167.249895018896, 4248.426462427564, 4278.593533614302, 47310.11289935143, 52516.73741631306, 65357.673211634115, 79777.41001654939, 93342.0, 12706.872931270755, 12839.935800321125, 12897.35513224335, 12956.416961236768, 13121.934390327988, 21510.677339839916, 21947.561048779255, 22004.77995220059, 23679.88160059223, 23857.642135367983, 9016.549172541347, 9378.48418336998, 9494.240460763122, 9508.477033763209, 9583.233341332676, 5261.5264626183825, 5278.0, 5290.259363689087, 5344.706041167696, 5407.756650950717, 3973.4039894016128, 4050.8177132029127, 4057.4522439470884, 4095.3037983542868, 4101.589841015874, 665.9467242620578, 666.5600703535644, 705.7141857547701, 730.631031329186, 737.7417903733758, 663.5355251324092, 671.358852296056, 685.1367277230726, 691.8754624167698, 706.7385067525049, 11636.36000020007, 11963.521459141537, 11963.64109076729, 12118.39408029595, 12176.452059657337, 854.7093988044095, 858.7981824271292, 876.9035406105323, 882.2853488674194, 886.3839631456206, 5514.653093761008, 5742.13867919807, 5753.59724819267, 5804.854878627983, 5826.592138550261, 81522.0, 86292.0, 87532.5623371879, 88297.0, 89746.0, 74354.6282268596, 76012.23987760051, 76771.61614192005, 78719.21280787233, 79326.0, 67591.0, 69135.3086469139, 69791.30208697848, 70651.0, 72245.2775472249, 10750.247482676137, 11068.335899846035, 11106.61126860556, 11109.11127109813, 11431.085513159094, 45999.31001035054, 46458.0, 46791.53208468008, 47280.52719472761, 47312.0, 54931.72534137464, 55101.0, 55397.7230113863, 55695.0, 56288.71855640696, 13726.434533060272, 13940.58178254654, 14041.508547201207, 14120.293985300488, 14396.0, 14778.113313201242, 15006.849931500545, 15101.169435681142, 15267.312970916113, 15890.443834465737, 14001.0, 14199.148051116967, 14438.0, 14664.926675366554, 15129.0166139205, 14098.929505352407, 14101.365438555085, 14420.278986050445, 14651.487197948021, 14749.631259218606, 13471.595852124452, 13648.0, 13648.385822637807, 13729.656758581115, 13766.65583360424, 8374.371922105745, 8436.746897593082, 8442.915570844458, 8484.830303394021, 8815.823683526422, 10624.734381640521, 10795.0, 10902.56389744433, 10907.236493445384, 10995.120390368591], "value": 7909.944123740843, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1461.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 113.0, 113.0, 113.0, 114.0, 112.0, 112.0, 113.0, 112.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 116.0, 117.0, 157.0, 122.0, 117.0, 118.0, 116.0, 132.0, 117.0], "value": 125.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 164.0, 161.0, 159.0, 163.0, 162.0, 161.0, 159.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 105.0, 76.0, 76.0, 77.0, 86.0, 91.0, 76.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 115.0, 82.0, 83.0, 83.0, 97.0, 82.0, 82.0, 100.0], "value": 88.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 114.0, 113.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 93.0, 93.0, 93.0, 93.0, 94.0, 94.0, 93.0], "value": 93.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 58.0, 56.0, 55.0, 56.0, 59.0, 59.0, 56.0, 55.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 55.0, 54.0, 53.0, 56.0, 53.0, 53.0, 53.0, 53.0], "value": 53.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 81.0, 77.0, 80.0, 76.0, 85.0, 79.0, 78.0, 80.0, 77.0], "value": 78.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 124.0, 131.0, 121.0, 135.0, 118.0, 122.0, 119.0, 165.0, 132.0], "value": 129.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 163.0, 159.0, 157.0, 158.0, 161.0, 163.0, 161.0, 159.0], "value": 160.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 60.0, 60.0, 60.0, 59.0, 60.0, 60.0, 60.0, 60.0], "value": 60.3, "unit": "score"}]}]} 07:45:16 INFO - Return code: 0 07:45:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:45:16 INFO - # TBPL SUCCESS # 07:45:16 INFO - Running post-action listener: _resource_record_post_action 07:45:16 INFO - [mozharness: 2017-05-17 14:45:16.891830Z] Finished run-tests step (success) 07:45:16 INFO - Running post-run listener: _resource_record_post_run 07:45:16 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 307200; Write bytes: 326471680; Read time: 28; Write time: 264500 07:45:16 INFO - TinderboxPrint: CPU usage
13.1% 07:45:16 INFO - TinderboxPrint: I/O read bytes / time
307,200 / 28 07:45:16 INFO - TinderboxPrint: I/O write bytes / time
326,471,680 / 264,500 07:45:16 INFO - TinderboxPrint: CPU idle
8,266.9 (86.9%) 07:45:16 INFO - TinderboxPrint: CPU user
1,197.7 (12.6%) 07:45:16 INFO - TinderboxPrint: Swap in / out
0 / 0 07:45:16 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 221184; Read time: 0; Write time: 40 07:45:16 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 303104; Write bytes: 326250496; Read time: 12; Write time: 264460 07:45:17 INFO - Running post-run listener: _upload_blobber_files 07:45:17 INFO - Blob upload gear active. 07:45:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:45:17 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 07:45:17 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'] 07:45:17 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 07:45:17 INFO - (blobuploader) - INFO - Open directory for files ... 07:45:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:45:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:45:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:45:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:21 INFO - (blobuploader) - INFO - Done attempting. 07:45:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:45:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:45:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:45:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:22 INFO - (blobuploader) - INFO - Done attempting. 07:45:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:45:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:45:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:22 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:45:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:22 INFO - (blobuploader) - INFO - Done attempting. 07:45:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:45:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:45:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:45:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:23 INFO - (blobuploader) - INFO - Done attempting. 07:45:23 INFO - (blobuploader) - INFO - Iteration through files over. 07:45:23 INFO - Return code: 0 07:45:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:45:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:45:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/933782ae260a299727434d8baaa03f75f1cac311e5622527e55ed219ad9f6628c87b6da573e3283449ff5b63da361a4572ba8e312757db1a6e39956de8e7cf2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/7fc5932aa79cffa7ad6c975d0a180271862f7c127ffa5c5687dd6f3e50526b0e3163f3eef35f5696d5cbe8858ea015ebd362d1966def31ecd539c51bcd0fe616", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5d51197f61caee975822b9f7dac2dca4cc7faa0533dd518d3e99730b302efc6c2b96c1f8cbcc48716d7b820d6f9ae1915d404d0a7b55d76cec60928235cae119", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c7b7658d35ec4b966c3b80676d8750c32510dcb1347f5f92bbb8c8bbd64ebcf202c4955850f1b3aac731d4f4cbd43aa78f92bd04360dbc6f778f81f8ca377e0f"} 07:45:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:45:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:45:23 INFO - Contents: 07:45:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/933782ae260a299727434d8baaa03f75f1cac311e5622527e55ed219ad9f6628c87b6da573e3283449ff5b63da361a4572ba8e312757db1a6e39956de8e7cf2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/7fc5932aa79cffa7ad6c975d0a180271862f7c127ffa5c5687dd6f3e50526b0e3163f3eef35f5696d5cbe8858ea015ebd362d1966def31ecd539c51bcd0fe616", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5d51197f61caee975822b9f7dac2dca4cc7faa0533dd518d3e99730b302efc6c2b96c1f8cbcc48716d7b820d6f9ae1915d404d0a7b55d76cec60928235cae119", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c7b7658d35ec4b966c3b80676d8750c32510dcb1347f5f92bbb8c8bbd64ebcf202c4955850f1b3aac731d4f4cbd43aa78f92bd04360dbc6f778f81f8ca377e0f"} 07:45:23 INFO - Running post-run listener: copy_logs_to_upload_dir 07:45:23 INFO - Copying logs to upload dir... 07:45:23 INFO - mkdir: /builds/slave/test/build/upload/logs 07:45:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.038740 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-05-17 07:45:23.387686) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-17 07:45:23.392763) ========= 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=52faae308a556c440401f8e5000001e8-1495031075.688370-235474031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/933782ae260a299727434d8baaa03f75f1cac311e5622527e55ed219ad9f6628c87b6da573e3283449ff5b63da361a4572ba8e312757db1a6e39956de8e7cf2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/7fc5932aa79cffa7ad6c975d0a180271862f7c127ffa5c5687dd6f3e50526b0e3163f3eef35f5696d5cbe8858ea015ebd362d1966def31ecd539c51bcd0fe616", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5d51197f61caee975822b9f7dac2dca4cc7faa0533dd518d3e99730b302efc6c2b96c1f8cbcc48716d7b820d6f9ae1915d404d0a7b55d76cec60928235cae119", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c7b7658d35ec4b966c3b80676d8750c32510dcb1347f5f92bbb8c8bbd64ebcf202c4955850f1b3aac731d4f4cbd43aa78f92bd04360dbc6f778f81f8ca377e0f"} build_url:https://queue.taskcluster.net/v1/task/SLcf356FSVybdxPEpLtiVg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011136 build_url: 'https://queue.taskcluster.net/v1/task/SLcf356FSVybdxPEpLtiVg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/933782ae260a299727434d8baaa03f75f1cac311e5622527e55ed219ad9f6628c87b6da573e3283449ff5b63da361a4572ba8e312757db1a6e39956de8e7cf2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/7fc5932aa79cffa7ad6c975d0a180271862f7c127ffa5c5687dd6f3e50526b0e3163f3eef35f5696d5cbe8858ea015ebd362d1966def31ecd539c51bcd0fe616", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5d51197f61caee975822b9f7dac2dca4cc7faa0533dd518d3e99730b302efc6c2b96c1f8cbcc48716d7b820d6f9ae1915d404d0a7b55d76cec60928235cae119", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c7b7658d35ec4b966c3b80676d8750c32510dcb1347f5f92bbb8c8bbd64ebcf202c4955850f1b3aac731d4f4cbd43aa78f92bd04360dbc6f778f81f8ca377e0f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-17 07:45:23.424574) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 07:45:23.424983) ========= 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=52faae308a556c440401f8e5000001e8-1495031075.688370-235474031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 07:45:23.510058) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-17 07:45:23.510541) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-17 07:45:23.510952) ========= ========= Total master_lag: 0.23 =========