builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-026 starttime: 1474975378.71 results: success (0) buildid: 20160927033952 builduid: 67c6f7906dd94832abc4f5744dc89427 revision: e289c0bdae843b7262108b3c53460ae1622530e9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 04:22:58.707995) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 04:22:58.708753) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 04:22:58.709350) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 04:22:58.727046) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 04:22:58.727365) ========= 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=41bf3e9aed84707956354da8000001c5-1474975308.293297-2130552337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-27 04:22:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-09-27 04:22:59 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119399 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 04:22:58.864066) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 04:22:58.864673) ========= 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=41bf3e9aed84707956354da8000001c5-1474975308.293297-2130552337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017746 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 04:22:58.916026) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 04:22:58.916892) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e289c0bdae843b7262108b3c53460ae1622530e9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev e289c0bdae843b7262108b3c53460ae1622530e9 --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=41bf3e9aed84707956354da8000001c5-1474975308.293297-2130552337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-27 04:22:59,838 truncating revision to first 12 chars 2016-09-27 04:22:59,838 Setting DEBUG logging. 2016-09-27 04:22:59,838 attempt 1/10 2016-09-27 04:22:59,838 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e289c0bdae84?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-27 04:23:00,912 unpacking tar archive at: fx-team-e289c0bdae84/testing/mozharness/ program finished with exit code 0 elapsedTime=1.432085 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 04:23:00.363822) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 04:23:00.364191) ========= script_repo_revision: e289c0bdae843b7262108b3c53460ae1622530e9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 04:23:00.364650) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 04:23:00.364969) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 04:23:00.374989) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-09-27 04:23:00.375325) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=41bf3e9aed84707956354da8000001c5-1474975308.293297-2130552337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:23:01 INFO - MultiFileLogger online at 20160927 04:23:01 in /builds/slave/test 04:23:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:23:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:23:01 INFO - {'append_to_log': False, 04:23:01 INFO - 'base_work_dir': '/builds/slave/test', 04:23:01 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:23:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:23:01 INFO - 'branch': 'Fx-Team-Non-PGO', 04:23:01 INFO - 'buildbot_json_path': 'buildprops.json', 04:23:01 INFO - 'config_files': ('talos/linux_config.py',), 04:23:01 INFO - 'default_actions': ('clobber', 04:23:01 INFO - 'read-buildbot-config', 04:23:01 INFO - 'download-and-extract', 04:23:01 INFO - 'populate-webroot', 04:23:01 INFO - 'create-virtualenv', 04:23:01 INFO - 'install', 04:23:01 INFO - 'run-tests'), 04:23:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:23:01 INFO - 'download_minidump_stackwalk': True, 04:23:01 INFO - 'download_symbols': 'ondemand', 04:23:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:23:01 INFO - 'tooltool.py': '/tools/tooltool.py', 04:23:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:23:01 INFO - '/tools/misc-python/virtualenv.py')}, 04:23:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:23:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:23:01 INFO - 'installer_path': 'installer.exe', 04:23:01 INFO - 'log_level': 'info', 04:23:01 INFO - 'log_name': 'talos', 04:23:01 INFO - 'log_to_console': True, 04:23:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:23:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:23:01 INFO - 'opt_config_files': (), 04:23:01 INFO - 'pip_index': False, 04:23:01 INFO - 'sps_profile': False, 04:23:01 INFO - 'sps_profile_interval': 0, 04:23:01 INFO - 'suite': 'dromaeojs', 04:23:01 INFO - 'system_bits': '32', 04:23:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:23:01 INFO - 'title': 'talos-linux64-ix-026', 04:23:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:23:01 INFO - 'use_talos_json': True, 04:23:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:23:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:23:01 INFO - 'work_dir': 'build'} 04:23:01 INFO - [mozharness: 2016-09-27 11:23:01.392770Z] Running clobber step. 04:23:01 INFO - Running pre-action listener: _resource_record_pre_action 04:23:01 INFO - Running main action method: clobber 04:23:01 INFO - rmtree: /builds/slave/test/build 04:23:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:23:02 INFO - Running post-action listener: _resource_record_post_action 04:23:02 INFO - [mozharness: 2016-09-27 11:23:02.374415Z] Finished clobber step (success) 04:23:02 INFO - [mozharness: 2016-09-27 11:23:02.374516Z] Running read-buildbot-config step. 04:23:02 INFO - Running pre-action listener: _resource_record_pre_action 04:23:02 INFO - Running main action method: read_buildbot_config 04:23:02 INFO - Using buildbot properties: 04:23:02 INFO - { 04:23:02 INFO - "project": "", 04:23:02 INFO - "product": "firefox", 04:23:02 INFO - "script_repo_revision": "production", 04:23:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:23:02 INFO - "repository": "", 04:23:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:23:02 INFO - "buildid": "20160927033952", 04:23:02 INFO - "pgo_build": "False", 04:23:02 INFO - "basedir": "/builds/slave/test", 04:23:02 INFO - "buildnumber": 2174, 04:23:02 INFO - "slavename": "talos-linux64-ix-026", 04:23:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:23:02 INFO - "platform": "ubuntu64_hw", 04:23:02 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:23:02 INFO - "branch": "fx-team", 04:23:02 INFO - "repo_path": "integration/fx-team", 04:23:02 INFO - "revision": "e289c0bdae843b7262108b3c53460ae1622530e9", 04:23:02 INFO - "stage_platform": "linux64", 04:23:02 INFO - "builduid": "67c6f7906dd94832abc4f5744dc89427", 04:23:02 INFO - "slavebuilddir": "test" 04:23:02 INFO - } 04:23:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/bIgegn4jQeGRfc8wTBh2Ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 04:23:02 INFO - Running post-action listener: _resource_record_post_action 04:23:02 INFO - [mozharness: 2016-09-27 11:23:02.376949Z] Finished read-buildbot-config step (success) 04:23:02 INFO - [mozharness: 2016-09-27 11:23:02.377039Z] Running download-and-extract step. 04:23:02 INFO - Running pre-action listener: _resource_record_pre_action 04:23:02 INFO - Running main action method: download_and_extract 04:23:02 INFO - mkdir: /builds/slave/test/build/tests 04:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:23:02 INFO - trying https://queue.taskcluster.net/v1/task/bIgegn4jQeGRfc8wTBh2Ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:23:02 INFO - Downloading https://queue.taskcluster.net/v1/task/bIgegn4jQeGRfc8wTBh2Ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:23:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bIgegn4jQeGRfc8wTBh2Ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:23:02 INFO - Downloaded 1361 bytes. 04:23:02 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:23:02 INFO - Using the following test package requirements: 04:23:02 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:23:02 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:23:02 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:23:02 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:02 INFO - u'jsshell-linux-x86_64.zip'], 04:23:02 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:23:02 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:23:02 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:23:02 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:23:02 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:23:02 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:23:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:23:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bIgegn4jQeGRfc8wTBh2Ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:23:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bIgegn4jQeGRfc8wTBh2Ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:23:02 INFO - Fetch https://queue.taskcluster.net/v1/task/bIgegn4jQeGRfc8wTBh2Ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:23:03 INFO - Expected file size: 20413413 04:23:07 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:23:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bIgegn4jQeGRfc8wTBh2Ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:23:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bIgegn4jQeGRfc8wTBh2Ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:23:07 INFO - Fetch https://queue.taskcluster.net/v1/task/bIgegn4jQeGRfc8wTBh2Ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:23:08 INFO - Expected file size: 20413413 04:23:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bIgegn4jQeGRfc8wTBh2Ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 04:23:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bIgegn4jQeGRfc8wTBh2Ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:23:13 INFO - Fetch https://queue.taskcluster.net/v1/task/bIgegn4jQeGRfc8wTBh2Ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 04:23:13 INFO - Expected file size: 14414057 04:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:23:14 INFO - trying https://queue.taskcluster.net/v1/task/bIgegn4jQeGRfc8wTBh2Ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:23:14 INFO - Downloading https://queue.taskcluster.net/v1/task/bIgegn4jQeGRfc8wTBh2Ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:23:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bIgegn4jQeGRfc8wTBh2Ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:23:15 INFO - Downloaded 55740504 bytes. 04:23:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bIgegn4jQeGRfc8wTBh2Ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:23:15 INFO - mkdir: /builds/slave/test/properties 04:23:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:23:15 INFO - Writing to file /builds/slave/test/properties/build_url 04:23:15 INFO - Contents: 04:23:15 INFO - build_url:https://queue.taskcluster.net/v1/task/bIgegn4jQeGRfc8wTBh2Ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:23:16 INFO - Running post-action listener: _resource_record_post_action 04:23:16 INFO - Running post-action listener: set_extra_try_arguments 04:23:16 INFO - [mozharness: 2016-09-27 11:23:16.007016Z] Finished download-and-extract step (success) 04:23:16 INFO - [mozharness: 2016-09-27 11:23:16.007244Z] Running populate-webroot step. 04:23:16 INFO - Running pre-action listener: _resource_record_pre_action 04:23:16 INFO - Running main action method: populate_webroot 04:23:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:23:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:23:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:23:16 INFO - '--tppagecycles', 04:23:16 INFO - '7'], 04:23:16 INFO - 'tests': ['tsvgm']}}, 04:23:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:23:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:23:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:23:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:23:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:23:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:23:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:16 INFO - 'talos_options': ['--disable-e10s'], 04:23:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:23:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:23:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:16 INFO - 'talos_options': ['--disable-e10s'], 04:23:16 INFO - 'tests': ['damp', 'tps']}, 04:23:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:16 INFO - 'tests': ['damp', 'tps']}, 04:23:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:23:16 INFO - 'tests': ['dromaeo_dom']}, 04:23:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:23:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:23:16 INFO - 'tests': ['basic_compositor_video']}, 04:23:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:23:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:23:16 INFO - 'tests': ['a11yr', 04:23:16 INFO - 'ts_paint', 04:23:16 INFO - 'tpaint', 04:23:16 INFO - 'sessionrestore', 04:23:16 INFO - 'sessionrestore_no_auto_restore', 04:23:16 INFO - 'tabpaint']}, 04:23:16 INFO - 'other-e10s': {'tests': ['a11yr', 04:23:16 INFO - 'ts_paint', 04:23:16 INFO - 'tpaint', 04:23:16 INFO - 'sessionrestore', 04:23:16 INFO - 'sessionrestore_no_auto_restore', 04:23:16 INFO - 'tabpaint']}, 04:23:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:23:16 INFO - 'ts_paint', 04:23:16 INFO - 'tpaint', 04:23:16 INFO - 'sessionrestore', 04:23:16 INFO - 'sessionrestore_no_auto_restore', 04:23:16 INFO - 'tabpaint']}, 04:23:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:23:16 INFO - 'ts_paint', 04:23:16 INFO - 'tpaint', 04:23:16 INFO - 'sessionrestore', 04:23:16 INFO - 'sessionrestore_no_auto_restore', 04:23:16 INFO - 'tabpaint']}, 04:23:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:23:16 INFO - 'tests': ['a11yr', 04:23:16 INFO - 'ts_paint', 04:23:16 INFO - 'tpaint', 04:23:16 INFO - 'sessionrestore', 04:23:16 INFO - 'sessionrestore_no_auto_restore', 04:23:16 INFO - 'tabpaint']}, 04:23:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:23:16 INFO - 'tests': ['a11yr', 04:23:16 INFO - 'ts_paint', 04:23:16 INFO - 'tpaint', 04:23:16 INFO - 'sessionrestore', 04:23:16 INFO - 'sessionrestore_no_auto_restore', 04:23:16 INFO - 'tabpaint']}, 04:23:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:23:16 INFO - 'tests': ['tsvgx', 04:23:16 INFO - 'tsvgr_opacity', 04:23:16 INFO - 'tart', 04:23:16 INFO - 'tscrollx', 04:23:16 INFO - 'cart']}, 04:23:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:23:16 INFO - 'tsvgr_opacity', 04:23:16 INFO - 'tart', 04:23:16 INFO - 'tscrollx', 04:23:16 INFO - 'cart']}, 04:23:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:16 INFO - 'talos_options': ['--disable-e10s'], 04:23:16 INFO - 'tests': ['tp5o']}, 04:23:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:16 INFO - 'tests': ['tp5o']}, 04:23:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:16 INFO - 'talos_options': ['--disable-e10s', 04:23:16 INFO - '--xperf_path', 04:23:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:23:16 INFO - 'tests': ['tp5n']}, 04:23:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:16 INFO - 'talos_options': ['--xperf_path', 04:23:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:23:16 INFO - 'tests': ['tp5n']}}, 04:23:16 INFO - 'talos.zip': {'path': '', 04:23:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:23:16 INFO - Running post-action listener: _resource_record_post_action 04:23:16 INFO - [mozharness: 2016-09-27 11:23:16.027040Z] Finished populate-webroot step (success) 04:23:16 INFO - [mozharness: 2016-09-27 11:23:16.027130Z] Running create-virtualenv step. 04:23:16 INFO - Running pre-action listener: _resource_record_pre_action 04:23:16 INFO - Running main action method: create_virtualenv 04:23:16 INFO - Creating virtualenv /builds/slave/test/build/venv 04:23:16 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 04:23:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:23:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:23:16 INFO - Using real prefix '/usr' 04:23:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:23:16 INFO - Installing distribute.............................................................................................................................................................................................done. 04:23:18 INFO - Installing pip.................done. 04:23:18 INFO - Return code: 0 04:23:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:23:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:23:18 INFO - Reading from file tmpfile_stdout 04:23:18 INFO - Output received: 04:23:18 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) 04:23:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:23:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:23:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:18 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f17a5faef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1788ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1785f60>, '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 0x1786d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17871d0>, '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': '41bf3e9aed84707956354da8000001c5-1474975308.293297-2130552337', '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 04:23:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 04:23:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:23:18 INFO - Using env: {'DISPLAY': ':0', 04:23:18 INFO - 'HOME': '/home/cltbld', 04:23:18 INFO - 'LANG': 'en_US.UTF-8', 04:23:18 INFO - 'LANGUAGE': 'en_US:en', 04:23:18 INFO - 'LOGNAME': 'cltbld', 04:23:18 INFO - 'MAIL': '/var/mail/cltbld', 04:23:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:18 INFO - 'MOZ_NO_REMOTE': '1', 04:23:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:18 INFO - 'NO_EM_RESTART': '1', 04:23:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:18 INFO - 'PWD': '/builds/slave/test', 04:23:18 INFO - 'SHELL': '/bin/bash', 04:23:18 INFO - 'SHLVL': '1', 04:23:18 INFO - 'TERM': 'linux', 04:23:18 INFO - 'TMOUT': '86400', 04:23:18 INFO - 'USER': 'cltbld', 04:23:18 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1474975308.293297-2130552337', 04:23:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:18 INFO - '_': '/tools/buildbot/bin/python'} 04:23:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:19 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 04:23:19 INFO - Cleaning up... 04:23:19 INFO - Return code: 0 04:23:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:23:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:19 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f17a5faef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1788ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1785f60>, '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 0x1786d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17871d0>, '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': '41bf3e9aed84707956354da8000001c5-1474975308.293297-2130552337', '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 04:23:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 04:23:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:23:19 INFO - Using env: {'DISPLAY': ':0', 04:23:19 INFO - 'HOME': '/home/cltbld', 04:23:19 INFO - 'LANG': 'en_US.UTF-8', 04:23:19 INFO - 'LANGUAGE': 'en_US:en', 04:23:19 INFO - 'LOGNAME': 'cltbld', 04:23:19 INFO - 'MAIL': '/var/mail/cltbld', 04:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:19 INFO - 'MOZ_NO_REMOTE': '1', 04:23:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:19 INFO - 'NO_EM_RESTART': '1', 04:23:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:19 INFO - 'PWD': '/builds/slave/test', 04:23:19 INFO - 'SHELL': '/bin/bash', 04:23:19 INFO - 'SHLVL': '1', 04:23:19 INFO - 'TERM': 'linux', 04:23:19 INFO - 'TMOUT': '86400', 04:23:19 INFO - 'USER': 'cltbld', 04:23:19 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1474975308.293297-2130552337', 04:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:19 INFO - '_': '/tools/buildbot/bin/python'} 04:23:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:19 INFO - Downloading/unpacking psutil>=3.1.1 04:23:19 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 04:23:19 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 04:23:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:19 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 04:23:19 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 04:23:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:23:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:23:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:23:21 INFO - Installing collected packages: psutil 04:23:21 INFO - Running setup.py install for psutil 04:23:21 INFO - building 'psutil._psutil_linux' extension 04:23:21 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 04:23:21 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 04:23:21 INFO - building 'psutil._psutil_posix' extension 04:23:21 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 04:23:21 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 04:23:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:23:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:23:21 INFO - Successfully installed psutil 04:23:21 INFO - Cleaning up... 04:23:22 INFO - Return code: 0 04:23:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:23:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:23:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f17a5faef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1788ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1785f60>, '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 0x1786d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17871d0>, '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': '41bf3e9aed84707956354da8000001c5-1474975308.293297-2130552337', '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 04:23:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 04:23:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:23:22 INFO - Using env: {'DISPLAY': ':0', 04:23:22 INFO - 'HOME': '/home/cltbld', 04:23:22 INFO - 'LANG': 'en_US.UTF-8', 04:23:22 INFO - 'LANGUAGE': 'en_US:en', 04:23:22 INFO - 'LOGNAME': 'cltbld', 04:23:22 INFO - 'MAIL': '/var/mail/cltbld', 04:23:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:22 INFO - 'MOZ_NO_REMOTE': '1', 04:23:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:22 INFO - 'NO_EM_RESTART': '1', 04:23:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:22 INFO - 'PWD': '/builds/slave/test', 04:23:22 INFO - 'SHELL': '/bin/bash', 04:23:22 INFO - 'SHLVL': '1', 04:23:22 INFO - 'TERM': 'linux', 04:23:22 INFO - 'TMOUT': '86400', 04:23:22 INFO - 'USER': 'cltbld', 04:23:22 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1474975308.293297-2130552337', 04:23:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:22 INFO - '_': '/tools/buildbot/bin/python'} 04:23:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:23:22 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 04:23:22 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 04:23:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:22 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 04:23:22 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 04:23:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:23:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:23:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:23:24 INFO - Installing collected packages: mozsystemmonitor 04:23:24 INFO - Running setup.py install for mozsystemmonitor 04:23:24 INFO - Successfully installed mozsystemmonitor 04:23:24 INFO - Cleaning up... 04:23:24 INFO - Return code: 0 04:23:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:23:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:24 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f17a5faef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1788ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1785f60>, '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 0x1786d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17871d0>, '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': '41bf3e9aed84707956354da8000001c5-1474975308.293297-2130552337', '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 04:23:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 04:23:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:23:24 INFO - Using env: {'DISPLAY': ':0', 04:23:24 INFO - 'HOME': '/home/cltbld', 04:23:24 INFO - 'LANG': 'en_US.UTF-8', 04:23:24 INFO - 'LANGUAGE': 'en_US:en', 04:23:24 INFO - 'LOGNAME': 'cltbld', 04:23:24 INFO - 'MAIL': '/var/mail/cltbld', 04:23:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:24 INFO - 'MOZ_NO_REMOTE': '1', 04:23:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:24 INFO - 'NO_EM_RESTART': '1', 04:23:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:24 INFO - 'PWD': '/builds/slave/test', 04:23:24 INFO - 'SHELL': '/bin/bash', 04:23:24 INFO - 'SHLVL': '1', 04:23:24 INFO - 'TERM': 'linux', 04:23:24 INFO - 'TMOUT': '86400', 04:23:24 INFO - 'USER': 'cltbld', 04:23:24 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1474975308.293297-2130552337', 04:23:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:24 INFO - '_': '/tools/buildbot/bin/python'} 04:23:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:24 INFO - Downloading/unpacking jsonschema==2.5.1 04:23:24 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 04:23:24 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 04:23:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:24 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 04:23:24 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 04:23:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:23:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:26 INFO - Downloading functools32-3.2.3-2.tar.gz 04:23:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:23:26 INFO - warning: no files found matching '*.txt' 04:23:26 INFO - no previously-included directories found matching 'build' 04:23:26 INFO - no previously-included directories found matching 'dist' 04:23:26 INFO - no previously-included directories found matching '.git*' 04:23:26 INFO - Installing collected packages: jsonschema, functools32 04:23:26 INFO - Running setup.py install for functools32 04:23:26 INFO - warning: no files found matching '*.txt' 04:23:26 INFO - no previously-included directories found matching 'build' 04:23:26 INFO - no previously-included directories found matching 'dist' 04:23:26 INFO - no previously-included directories found matching '.git*' 04:23:26 INFO - Successfully installed jsonschema functools32 04:23:26 INFO - Cleaning up... 04:23:26 INFO - Return code: 0 04:23:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:23:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:23:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f17a5faef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1788ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1785f60>, '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 0x1786d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17871d0>, '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': '41bf3e9aed84707956354da8000001c5-1474975308.293297-2130552337', '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 04:23:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 04:23:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:23:26 INFO - Using env: {'DISPLAY': ':0', 04:23:26 INFO - 'HOME': '/home/cltbld', 04:23:26 INFO - 'LANG': 'en_US.UTF-8', 04:23:26 INFO - 'LANGUAGE': 'en_US:en', 04:23:26 INFO - 'LOGNAME': 'cltbld', 04:23:26 INFO - 'MAIL': '/var/mail/cltbld', 04:23:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:26 INFO - 'MOZ_NO_REMOTE': '1', 04:23:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:26 INFO - 'NO_EM_RESTART': '1', 04:23:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:26 INFO - 'PWD': '/builds/slave/test', 04:23:26 INFO - 'SHELL': '/bin/bash', 04:23:26 INFO - 'SHLVL': '1', 04:23:26 INFO - 'TERM': 'linux', 04:23:26 INFO - 'TMOUT': '86400', 04:23:26 INFO - 'USER': 'cltbld', 04:23:26 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1474975308.293297-2130552337', 04:23:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:26 INFO - '_': '/tools/buildbot/bin/python'} 04:23:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:23:27 INFO - Cleaning up... 04:23:27 INFO - Return code: 0 04:23:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:23:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:23:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:27 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f17a5faef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1788ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1785f60>, '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 0x1786d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17871d0>, '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': '41bf3e9aed84707956354da8000001c5-1474975308.293297-2130552337', '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 04:23:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 04:23:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:23:27 INFO - Using env: {'DISPLAY': ':0', 04:23:27 INFO - 'HOME': '/home/cltbld', 04:23:27 INFO - 'LANG': 'en_US.UTF-8', 04:23:27 INFO - 'LANGUAGE': 'en_US:en', 04:23:27 INFO - 'LOGNAME': 'cltbld', 04:23:27 INFO - 'MAIL': '/var/mail/cltbld', 04:23:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:27 INFO - 'MOZ_NO_REMOTE': '1', 04:23:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:27 INFO - 'NO_EM_RESTART': '1', 04:23:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:27 INFO - 'PWD': '/builds/slave/test', 04:23:27 INFO - 'SHELL': '/bin/bash', 04:23:27 INFO - 'SHLVL': '1', 04:23:27 INFO - 'TERM': 'linux', 04:23:27 INFO - 'TMOUT': '86400', 04:23:27 INFO - 'USER': 'cltbld', 04:23:27 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1474975308.293297-2130552337', 04:23:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:27 INFO - '_': '/tools/buildbot/bin/python'} 04:23:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:27 INFO - Downloading/unpacking blobuploader==1.2.4 04:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:29 INFO - Downloading blobuploader-1.2.4.tar.gz 04:23:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:23:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:23:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:29 INFO - Downloading docopt-0.6.1.tar.gz 04:23:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:23:30 INFO - Installing collected packages: blobuploader, requests, docopt 04:23:30 INFO - Running setup.py install for blobuploader 04:23:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:23:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:23:30 INFO - Running setup.py install for requests 04:23:30 INFO - Running setup.py install for docopt 04:23:30 INFO - Successfully installed blobuploader requests docopt 04:23:30 INFO - Cleaning up... 04:23:30 INFO - Return code: 0 04:23:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:23:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:23:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:30 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f17a5faef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1788ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1785f60>, '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 0x1786d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17871d0>, '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': '41bf3e9aed84707956354da8000001c5-1474975308.293297-2130552337', '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 04:23:30 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 04:23:30 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:23:30 INFO - Using env: {'DISPLAY': ':0', 04:23:30 INFO - 'HOME': '/home/cltbld', 04:23:30 INFO - 'LANG': 'en_US.UTF-8', 04:23:30 INFO - 'LANGUAGE': 'en_US:en', 04:23:30 INFO - 'LOGNAME': 'cltbld', 04:23:30 INFO - 'MAIL': '/var/mail/cltbld', 04:23:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:30 INFO - 'MOZ_NO_REMOTE': '1', 04:23:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:30 INFO - 'NO_EM_RESTART': '1', 04:23:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:30 INFO - 'PWD': '/builds/slave/test', 04:23:30 INFO - 'SHELL': '/bin/bash', 04:23:30 INFO - 'SHLVL': '1', 04:23:30 INFO - 'TERM': 'linux', 04:23:30 INFO - 'TMOUT': '86400', 04:23:30 INFO - 'USER': 'cltbld', 04:23:30 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1474975308.293297-2130552337', 04:23:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:30 INFO - '_': '/tools/buildbot/bin/python'} 04:23:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:23:30 INFO - Running setup.py (path:/tmp/pip-5z1hwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:23:30 INFO - Running setup.py (path:/tmp/pip-qL68wp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:23:30 INFO - Running setup.py (path:/tmp/pip-S73dFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:23:31 INFO - Running setup.py (path:/tmp/pip-Mrn9Na-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:23:31 INFO - Running setup.py (path:/tmp/pip-lCTROa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:23:31 INFO - Running setup.py (path:/tmp/pip-iUg1Ah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:23:31 INFO - Running setup.py (path:/tmp/pip-2NyuPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:23:31 INFO - Running setup.py (path:/tmp/pip-OJJ8tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:23:31 INFO - Running setup.py (path:/tmp/pip-gN9dS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:23:31 INFO - Running setup.py (path:/tmp/pip-Y17bvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:23:31 INFO - Running setup.py (path:/tmp/pip-JxXRdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:23:31 INFO - Running setup.py (path:/tmp/pip-Taj6YP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:23:31 INFO - Running setup.py (path:/tmp/pip-OKLinp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:23:31 INFO - Running setup.py (path:/tmp/pip-oYzcq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:31 INFO - Running setup.py (path:/tmp/pip-rjFjoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:23:31 INFO - Running setup.py (path:/tmp/pip-Jzq0lv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:23:31 INFO - Running setup.py (path:/tmp/pip-l6iK4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:23:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:23:32 INFO - Running setup.py install for manifestparser 04:23:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:23:32 INFO - Running setup.py install for mozcrash 04:23:32 INFO - Running setup.py install for mozdebug 04:23:32 INFO - Running setup.py install for mozdevice 04:23:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:23:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:23:32 INFO - Running setup.py install for mozfile 04:23:32 INFO - Running setup.py install for mozhttpd 04:23:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:23:32 INFO - Running setup.py install for mozinfo 04:23:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:23:32 INFO - Running setup.py install for mozInstall 04:23:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:23:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:23:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:23:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:23:32 INFO - Running setup.py install for mozleak 04:23:32 INFO - Running setup.py install for mozlog 04:23:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:23:33 INFO - Running setup.py install for moznetwork 04:23:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:23:33 INFO - Running setup.py install for mozprocess 04:23:33 INFO - Running setup.py install for mozprofile 04:23:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:23:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:23:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:23:33 INFO - Running setup.py install for mozrunner 04:23:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:23:33 INFO - Running setup.py install for mozscreenshot 04:23:33 INFO - Running setup.py install for moztest 04:23:33 INFO - Running setup.py install for mozversion 04:23:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:23:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:23:33 INFO - Cleaning up... 04:23:33 INFO - Return code: 0 04:23:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:23:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:33 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f17a5faef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1788ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1785f60>, '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 0x1786d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17871d0>, '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': '41bf3e9aed84707956354da8000001c5-1474975308.293297-2130552337', '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 04:23:33 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 04:23:33 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:23:33 INFO - Using env: {'DISPLAY': ':0', 04:23:33 INFO - 'HOME': '/home/cltbld', 04:23:33 INFO - 'LANG': 'en_US.UTF-8', 04:23:33 INFO - 'LANGUAGE': 'en_US:en', 04:23:33 INFO - 'LOGNAME': 'cltbld', 04:23:33 INFO - 'MAIL': '/var/mail/cltbld', 04:23:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:33 INFO - 'MOZ_NO_REMOTE': '1', 04:23:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:33 INFO - 'NO_EM_RESTART': '1', 04:23:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:33 INFO - 'PWD': '/builds/slave/test', 04:23:33 INFO - 'SHELL': '/bin/bash', 04:23:33 INFO - 'SHLVL': '1', 04:23:33 INFO - 'TERM': 'linux', 04:23:33 INFO - 'TMOUT': '86400', 04:23:33 INFO - 'USER': 'cltbld', 04:23:33 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1474975308.293297-2130552337', 04:23:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:33 INFO - '_': '/tools/buildbot/bin/python'} 04:23:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:23:34 INFO - Running setup.py (path:/tmp/pip-9gTL7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:23:34 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:23:34 INFO - Running setup.py (path:/tmp/pip-19o2KK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:23:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 04:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:23:34 INFO - Running setup.py (path:/tmp/pip-BlWAY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:23:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:23:34 INFO - Running setup.py (path:/tmp/pip-G7rwjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:23:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 04:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:23:34 INFO - Running setup.py (path:/tmp/pip-Ynb_bV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:23:34 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)) 04:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:23:34 INFO - Running setup.py (path:/tmp/pip-yjt_JN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:23:34 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)) 04:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:23:34 INFO - Running setup.py (path:/tmp/pip-QxD8gr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:23:34 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)) 04:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:23:34 INFO - Running setup.py (path:/tmp/pip-1HIjKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:23:34 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)) 04:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:23:34 INFO - Running setup.py (path:/tmp/pip-wvL80i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:23:34 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)) 04:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:23:34 INFO - Running setup.py (path:/tmp/pip-7mkalp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:23:34 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)) 04:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:23:34 INFO - Running setup.py (path:/tmp/pip-CJ8FZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:23:34 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)) 04:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:23:34 INFO - Running setup.py (path:/tmp/pip-ijQLYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:23:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 04:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:23:34 INFO - Running setup.py (path:/tmp/pip-JD5CBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:23:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:23:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:23:35 INFO - Running setup.py (path:/tmp/pip-qz5RpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:23:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 04:23:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:35 INFO - Running setup.py (path:/tmp/pip-U2iYxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:23:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:23:35 INFO - Running setup.py (path:/tmp/pip-rrODJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:23:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 04:23:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:23:35 INFO - Running setup.py (path:/tmp/pip-ODDvcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:23:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:23:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:23:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:23:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:23:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:23:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:23:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:23:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:37 INFO - Downloading blessings-1.6.tar.gz 04:23:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:23:37 INFO - Installing collected packages: blessings 04:23:37 INFO - Running setup.py install for blessings 04:23:37 INFO - Successfully installed blessings 04:23:37 INFO - Cleaning up... 04:23:37 INFO - Return code: 0 04:23:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:23:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:23:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:23:37 INFO - Reading from file tmpfile_stdout 04:23:37 INFO - Current package versions: 04:23:37 INFO - argparse == 1.2.1 04:23:37 INFO - blessings == 1.6 04:23:37 INFO - blobuploader == 1.2.4 04:23:37 INFO - docopt == 0.6.1 04:23:37 INFO - functools32 == 3.2.3-2 04:23:37 INFO - jsonschema == 2.5.1 04:23:37 INFO - manifestparser == 1.1 04:23:37 INFO - mozInstall == 1.12 04:23:37 INFO - mozcrash == 0.17 04:23:37 INFO - mozdebug == 0.1 04:23:37 INFO - mozdevice == 0.48 04:23:37 INFO - mozfile == 1.2 04:23:37 INFO - mozhttpd == 0.7 04:23:37 INFO - mozinfo == 0.9 04:23:37 INFO - mozleak == 0.1 04:23:37 INFO - mozlog == 3.4 04:23:37 INFO - moznetwork == 0.27 04:23:37 INFO - mozprocess == 0.23 04:23:37 INFO - mozprofile == 0.28 04:23:37 INFO - mozrunner == 6.12 04:23:37 INFO - mozscreenshot == 0.1 04:23:37 INFO - mozsystemmonitor == 0.3 04:23:37 INFO - moztest == 0.7 04:23:37 INFO - mozversion == 1.4 04:23:37 INFO - psutil == 3.1.1 04:23:37 INFO - requests == 1.2.3 04:23:37 INFO - wsgiref == 0.1.2 04:23:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:23:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f17a5faef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1788ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1785f60>, '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 0x1786d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17871d0>, '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': '41bf3e9aed84707956354da8000001c5-1474975308.293297-2130552337', '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 04:23:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 04:23:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:23:37 INFO - Using env: {'DISPLAY': ':0', 04:23:37 INFO - 'HOME': '/home/cltbld', 04:23:37 INFO - 'LANG': 'en_US.UTF-8', 04:23:37 INFO - 'LANGUAGE': 'en_US:en', 04:23:37 INFO - 'LOGNAME': 'cltbld', 04:23:37 INFO - 'MAIL': '/var/mail/cltbld', 04:23:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:37 INFO - 'MOZ_NO_REMOTE': '1', 04:23:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:37 INFO - 'NO_EM_RESTART': '1', 04:23:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:37 INFO - 'PWD': '/builds/slave/test', 04:23:37 INFO - 'SHELL': '/bin/bash', 04:23:37 INFO - 'SHLVL': '1', 04:23:37 INFO - 'TERM': 'linux', 04:23:37 INFO - 'TMOUT': '86400', 04:23:37 INFO - 'USER': 'cltbld', 04:23:37 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1474975308.293297-2130552337', 04:23:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:37 INFO - '_': '/tools/buildbot/bin/python'} 04:23:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:23:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:23:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:23:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:23:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:23:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:23:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:23:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:23:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:23:37 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:23:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:23:37 INFO - Cleaning up... 04:23:37 INFO - Return code: 0 04:23:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:23:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f17a5faef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1788ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1785f60>, '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 0x1786d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17871d0>, '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': '41bf3e9aed84707956354da8000001c5-1474975308.293297-2130552337', '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 04:23:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:23:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:23:37 INFO - Using env: {'DISPLAY': ':0', 04:23:37 INFO - 'HOME': '/home/cltbld', 04:23:37 INFO - 'LANG': 'en_US.UTF-8', 04:23:37 INFO - 'LANGUAGE': 'en_US:en', 04:23:37 INFO - 'LOGNAME': 'cltbld', 04:23:37 INFO - 'MAIL': '/var/mail/cltbld', 04:23:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:37 INFO - 'MOZ_NO_REMOTE': '1', 04:23:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:37 INFO - 'NO_EM_RESTART': '1', 04:23:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:37 INFO - 'PWD': '/builds/slave/test', 04:23:37 INFO - 'SHELL': '/bin/bash', 04:23:37 INFO - 'SHLVL': '1', 04:23:37 INFO - 'TERM': 'linux', 04:23:37 INFO - 'TMOUT': '86400', 04:23:37 INFO - 'USER': 'cltbld', 04:23:37 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1474975308.293297-2130552337', 04:23:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:37 INFO - '_': '/tools/buildbot/bin/python'} 04:23:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:23:38 INFO - Cleaning up... 04:23:38 INFO - Return code: 0 04:23:38 INFO - Running post-action listener: _resource_record_post_action 04:23:38 INFO - Running post-action listener: _start_resource_monitoring 04:23:38 INFO - Starting resource monitoring. 04:23:38 INFO - [mozharness: 2016-09-27 11:23:38.137916Z] Finished create-virtualenv step (success) 04:23:38 INFO - [mozharness: 2016-09-27 11:23:38.138377Z] Running install step. 04:23:38 INFO - Running pre-action listener: _resource_record_pre_action 04:23:38 INFO - Running main action method: install 04:23:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:23:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:23:38 INFO - Reading from file tmpfile_stdout 04:23:38 INFO - Detecting whether we're running mozinstall >=1.0... 04:23:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:23:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:23:38 INFO - Reading from file tmpfile_stdout 04:23:38 INFO - Output received: 04:23:38 INFO - Usage: mozinstall [options] installer 04:23:38 INFO - Options: 04:23:38 INFO - -h, --help show this help message and exit 04:23:38 INFO - -d DEST, --destination=DEST 04:23:38 INFO - Directory to install application into. [default: 04:23:38 INFO - "/builds/slave/test"] 04:23:38 INFO - --app=APP Application being installed. [default: firefox] 04:23:38 INFO - mkdir: /builds/slave/test/build/application 04:23:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:23:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:23:54 INFO - Reading from file tmpfile_stdout 04:23:54 INFO - Output received: 04:23:54 INFO - /builds/slave/test/build/application/firefox/firefox 04:23:54 INFO - Running post-action listener: _resource_record_post_action 04:23:54 INFO - [mozharness: 2016-09-27 11:23:54.523925Z] Finished install step (success) 04:23:54 INFO - [mozharness: 2016-09-27 11:23:54.524169Z] Running run-tests step. 04:23:54 INFO - Running pre-action listener: _resource_record_pre_action 04:23:54 INFO - Running main action method: run_tests 04:23:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:23:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:23:54 INFO - Python 2.7.3 04:23:54 INFO - Return code: 0 04:23:54 INFO - grabbing minidump binary from tooltool 04:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:23:54 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 0x1785f60>, '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 0x1786d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17871d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:23:54 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 04:23:54 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 04:23:54 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 04:23:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:23:54 INFO - Return code: 0 04:23:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:23:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:23:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:23:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:23:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:23:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bIgegn4jQeGRfc8wTBh2Ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 04:23:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bIgegn4jQeGRfc8wTBh2Ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 04:23:54 INFO - Using env: {'DISPLAY': ':0', 04:23:54 INFO - 'HOME': '/home/cltbld', 04:23:54 INFO - 'LANG': 'en_US.UTF-8', 04:23:54 INFO - 'LANGUAGE': 'en_US:en', 04:23:54 INFO - 'LOGNAME': 'cltbld', 04:23:54 INFO - 'MAIL': '/var/mail/cltbld', 04:23:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:23:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:54 INFO - 'MOZ_NO_REMOTE': '1', 04:23:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:23:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:54 INFO - 'NO_EM_RESTART': '1', 04:23:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:54 INFO - 'PWD': '/builds/slave/test', 04:23:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:23:54 INFO - 'SHELL': '/bin/bash', 04:23:54 INFO - 'SHLVL': '1', 04:23:54 INFO - 'TERM': 'linux', 04:23:54 INFO - 'TMOUT': '86400', 04:23:54 INFO - 'USER': 'cltbld', 04:23:54 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1474975308.293297-2130552337', 04:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:54 INFO - '_': '/tools/buildbot/bin/python'} 04:23:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bIgegn4jQeGRfc8wTBh2Ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 04:23:54 INFO - mozversion application_buildid: 20160927033952 04:23:54 INFO - mozversion application_changeset: e289c0bdae843b7262108b3c53460ae1622530e9 04:23:54 INFO - mozversion application_display_name: Nightly 04:23:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:23:54 INFO - mozversion application_name: Firefox 04:23:54 INFO - mozversion application_remotingname: firefox 04:23:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:23:54 INFO - mozversion application_vendor: Mozilla 04:23:54 INFO - mozversion application_version: 52.0a1 04:23:54 INFO - mozversion platform_buildid: 20160927033952 04:23:54 INFO - mozversion platform_changeset: e289c0bdae843b7262108b3c53460ae1622530e9 04:23:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:23:54 INFO - mozversion platform_version: 52.0a1 04:23:54 INFO - using testdate: 1474975434 04:23:54 INFO - actual date: 1474975434 04:23:54 INFO - starting webserver on 'localhost:40833' 04:23:54 INFO - SUITE-START | Running 2 tests 04:23:54 INFO - TEST-START | dromaeo_css 04:23:54 INFO - operating with platform_type : linux_ 04:23:54 INFO - Initialising browser for dromaeo_css test... 04:23:54 INFO - TEST-INFO | started process 5306 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4yBk9f/profile http://localhost:40833/getInfo.html) 04:23:59 INFO - PROCESS | 5306 | __metrics Screen width/height:1600/1200 04:23:59 INFO - PROCESS | 5306 | colorDepth:24 04:23:59 INFO - PROCESS | 5306 | Browser inner width/height: 1024/697 04:23:59 INFO - PROCESS | 5306 | __metrics 04:24:00 INFO - PROCESS | 5306 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:24:00 INFO - PROCESS | 5306 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:24:00 INFO - PROCESS | 5306 | console.error: PushService: 04:24:00 INFO - PROCESS | 5306 | stateChangeProcessEnqueue: Error transitioning state 04:24:00 INFO - PROCESS | 5306 | UnknownError 04:24:01 INFO - TEST-INFO | 5306: exit 0 04:24:01 INFO - Browser initialized. 04:24:01 INFO - Running cycle 1/1 for dromaeo_css test... 04:24:01 INFO - TEST-INFO | started process 5389 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4yBk9f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:24:13 INFO - PROCESS | 5389 | RSS: Main: 174977024 04:24:13 INFO - PROCESS | 5389 | 04:25:05 INFO - PROCESS | 5389 | 1474975505364 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:27:17 INFO - PROCESS | 5389 | Cycle 1(1): loaded http://localhost:40833/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40833/tests/dromaeo/cssquery-ext.html) 04:27:19 INFO - PROCESS | 5389 | RSS: Main: 286216192 04:27:19 INFO - PROCESS | 5389 | 04:30:21 INFO - PROCESS | 5389 | Cycle 1(1): loaded http://localhost:40833/tests/dromaeo/cssquery-ext.html (next: http://localhost:40833/tests/dromaeo/cssquery-jquery.html) 04:30:22 INFO - PROCESS | 5389 | RSS: Main: 280944640 04:30:22 INFO - PROCESS | 5389 | 04:33:24 INFO - PROCESS | 5389 | Cycle 1(1): loaded http://localhost:40833/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40833/tests/dromaeo/cssquery-mootools.html) 04:33:25 INFO - PROCESS | 5389 | RSS: Main: 255307776 04:33:25 INFO - PROCESS | 5389 | 04:36:27 INFO - PROCESS | 5389 | Cycle 1(1): loaded http://localhost:40833/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40833/tests/dromaeo/cssquery-prototype.html) 04:36:28 INFO - PROCESS | 5389 | RSS: Main: 219516928 04:36:28 INFO - PROCESS | 5389 | 04:39:31 INFO - PROCESS | 5389 | Cycle 1(1): loaded http://localhost:40833/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40833/tests/dromaeo/cssquery-yui.html) 04:39:31 INFO - PROCESS | 5389 | RSS: Main: 221171712 04:39:31 INFO - PROCESS | 5389 | 04:42:34 INFO - PROCESS | 5389 | Cycle 1(1): loaded http://localhost:40833/tests/dromaeo/cssquery-yui.html (next: http://localhost:40833/tests/dromaeo/cssquery-dojo.html) 04:42:35 INFO - PROCESS | 5389 | RSS: Main: 309915648 04:42:35 INFO - PROCESS | 5389 | 04:42:35 INFO - PROCESS | 5389 | __start_tp_report 04:42:35 INFO - PROCESS | 5389 | _x_x_mozilla_page_load 04:42:35 INFO - PROCESS | 5389 | _x_x_mozilla_page_load_details 04:42:35 INFO - PROCESS | 5389 | |i|pagename|runs| 04:42:35 INFO - PROCESS | 5389 | |0;dojo.html;2570.2032369965314;2613.4773045390925;2640.7227241139685;2649.668791401075;2661.7205193454674;4628.1669299526075;4688.695234809735;4730.550597693222;4768.070226305867;4772.570468657825;4676;4703.035877645083;4722.527747225276;4735.3607263019485;4806.567408933195;4310.590493903074;4331.112122014995;4362.105768317503;4366.890827729317;4390.4511936008;4409.360642706805;4412.029353542232;4440.555944405566;4442.689011769177;4488.842890498833;4387.736735795863;4417.977910110445;4432.534583868695;4433.889152771207;4473.597376236138;4184.853530126431;4220.240356735786;4221.134667393177;4347.369631403429;4392.428984232061;4302.806373713191;4304.074623955865;4314;4421.049474363027;4427.800748966304;4726.645501587394;4746.5490778376;4748;4783.545563171493;4826.155422801031;4884.365032545782;4974.90050198994;5046;5095.923561146586;5105.872353191163;5127.589792816566;5136.229565565158;5142.562882155022;5143.27994080829;5190.377154741455;4777.06847164803;4791.6406269529925;4794.400699912511;4798.520147985243;4845.055214233191;5101.056304583664;5155.793768249303;5175.404828444702;5240.9213861792105;5300.469953004668;5005.649604527648;5022.347094877642;5024.899502009939;5077.289179514871;5089.262057001714;5094.77073531692;5102.821401250939;5105.948940510547;5109.795608175706;5179.171332586768;4902.632302577321;4974.17926042199;5052.292679024939;5052.797888084509;5060.063888180698;4947.6536642434685;4958.983408401269;4994.076095922266;5008.649394542347;5012.072766538202;4359.694821362475;4375.256206444912;4378.5183629800695;4397.8240870364825;4424.7123936944;3775.3770627846648;3777.697784177259;3782;3823.4647149399107;3869.8258578364043;4313.331433627793;4370.38814565961;4379.364992076131;4420.115976804652;4430.778461076933;4972.577330926912;4979.45226025137;5013.072581572421;5036.7733451994745;5164.509371609691;4342.1749867525705;4345.456817897762;4384.210842048462;4399.208142534375;4403.427554417905;4572.817087316536;4584.17484852723;4585.037142200109;4587.655925805578;4641.675082744243;4610.5389461054965;4662.976685116552;4741.431028276629;4752.42970843501;4761.738104404152;5082.059818933509;5118.360204974379;5122.308488354024;5152.948470515247;5190.247414125006;4759.76201189946;4778.092162489255;4778.928316075192;4782.210935195653;4834.274858771212;4894.510548945077;4953.7523123844385;5074.619403544675;5082.2122571001555;5145.459726728789;5040.218766091261;5070.062038522885;5083.161278389024;5093.134167191661;5152.458991805806;4954.281629163823;4961.652684312064;4964.081644895706;4968.254761785761;5028.446870844277;4849.878753031202;4927.384076990376;4964.379452568429;4975.203967365204;5031.52200540948;4841.782119804688;4865.781039853145;4938.802447902043;4944.060628480721;5014.598832093497;5048.040872234411;5052.368453943257;5067.543921047123;5071.87320316995;5073.720945348041;4778.187708089703;4836.395450568679;4842.055799119138;4929.950700493093;4942.1104201244125 04:42:35 INFO - PROCESS | 5389 | |1;ext.html;565.3103214078824;574.3251679276849;575.2004713448307;576.5186069631857;581.7731084876901;28440.431191376185;31409.528857067162;31427;37972.21569578237;39244.607553924456;39766;40169;40182.19635607286;40229.798851005704;40304.395434068436;7546.358559522447;7670.808229794272;7688.231176882323;7701.191374905638;7702.191269916662;7341.853162936738;7519.473636845396;7528.39772818176;7603.847923041536;7828.725994590191;7338.486305958585;10070.295079344449;10394.844077338847;10415.583376664925;10416;9891.752706182368;9968.551415186334;9973.601055957753;9976.90023099767;9980.550875210633;9629.566669499889;9712.077352651557;9713.514324283828;9713.805723885484;9722.222222222204;38702.612973870186;38944.02639933996;38962.805185974175;39044.41433378502;39097.60902390968;2838.247864315958;3043.5282531207476;3044.9086527404215;3109.6268447786183;3263.6573159818113;28373.574396384072;28393;28514.287142821388;28939.85530072336;29864.8506757467;3425.3491836550975;3471.687548120656;3508.14050557615;3508.8771892983877;3558.4128618777872;261024;261067;261812;261972;263568.9999999981;51775.22337164945;52184.47815521872;52190.47809521856;52241.47758522442;52321.215181772306;31898.681013190035;33012.50481242783;33051.83474082614;35099;35101.64898351035;13923.164610123426;14116.294185290695;14118.647033824236;14118.85881141196;14119.294035298399;10237.692869213935;10288.537015834305;10291.639792607222;10292.897071029194;10302.948485257675;15415.768763468557;15730;16887.408940687263;17230;17336.826631733773;6577.322782690383;6592;6677.298883617247;6938.653067346713;7110.680019399036;792.2908996448147;890.6348397157135;896.789254525186;956.4357029352576;1010.6917390195914;27675.86162069177;28051.43897122087;28203.077353755532;28646.427071458453;28844.711552884623;938.8403971324891;954.8233576788316;983.7540614846289;992.2805965674828;998.83519219328;14579;15120.54638360851;15195.164265965257;15213.315400806769;15251.92374038145;370070;374424;375319;375406;375648;43572.56427435685;44288.77855610701;44345.334819977725;50469;52958.47041529613;1059.4543809937888;1172.407933993345;1199.6760874563993;1207.8309036734863;1210.5218438716481;27641.723582763916;29075.7092429073;29835;30159;30181;43130.353044704985;43345.714871344106;43398.132037359705;43408.782956085015;43533.78233108814;377838;387195;387946;585129;589775;38127.80936095302;38548.42177367285;38566;38724.22551548897;39423.21153576855;41987.37018944657;42187;42197.578024220595;42366.57633423626;43237;34997.30005399827;35395.46906796349;35415.64584354227;35642.28715425625;35661.465078023335;36167;36710.26579468449;36764.816175918946;36768.63231367652;36908.630913691595;35827.82086089553;35831.64168358283;35952.82023589865;35997.64002359943;36327;31092.533611996292;31571;32580.090389153454;33155.33689326248;35403;25330.746692532837;25734.485310293316;25837.612435813855;25947.198609543015;25985.350366240997 04:42:35 INFO - PROCESS | 5389 | |2;jquery.html;343.7421933549838;360.7060245899593;366.6132230496826;370.24654827426184;381.9446180303856;12484.875151248485;15677.52967410978;15739.055656660594;16189.35242590295;17076.402325918596;16457.423990160347;16576.17119144044;16611.750823737653;16872.83127168728;16982.915085424585;4859.343988561552;5062.443131255559;5157.277981082651;5363.436839131893;5417.918731219035;3378.1216883610314;5391.406945236021;5430.809921652743;5440.891182176374;5449.04641687705;3498.6151523332414;5135.58915286778;5332.120200166968;5377.865553361158;5480.479354461319;5427;5478.342598888119;5483.424240454755;5487.945120548783;5912.645241285537;5255.922535880135;5257.290265814105;5258.7370631468275;5262.0791361511965;5278.841634750964;12012.759744805142;12208.877911220952;18384.863405733737;19035.428937131906;19168.13743381551;1888.8488920886296;2074.968875466869;2127.659574468093;2271.4775601611555;2339.1695947938406;8807.823843523158;8843.60203790831;8966.730998070068;9127.726168214964;9145.954270228607;1610.4443966831425;1648.5796121988817;1651.983480165195;1762.938297159606;1765.3821162593117;67386;69229.65385173092;70091.29908700899;70490.64754676246;71497;8971.372003959661;9018.188363047226;9110.908890911138;9225.215856652125;9554.952225238969;12872.356382180853;12888.226706397647;12888.484460621657;12925.612231633066;12937.159084659466;6415.807525774234;6539.280679125292;6544.181977252843;6554.541182117206;6794.898076528856;6078.392160783975;6117.541184411098;6127.172831667757;6214.875702486015;6448.322926092693;4009.51885773709;4077.245709543744;4157.605027522381;4168.437260969791;4299.591538803808;1696.6267421167324;1716.6738319719213;1720.5698575356162;1775.2810111904698;1783.456045905985;862.254150160107;870.9608067636972;877;899.132337294514;929.4934260827865;15173.317200725995;15629;15828.60428489297;16607.3357065716;17012.48962531126;825.9917400826035;828.5194587139445;837.8031162676766;845.678642115992;896.5920506169678;8753.24935013;9272.860907086399;9291.442513449214;9324.440533568008;9450.43297402158;368489;371835;372054;372098;372836;73378;75001;76440;77464.61267693738;78646.6067669658;851.3912552524974;870.0081906626451;870.4864130163107;870.7083127152348;874.0516539554654;14188.432462701376;14369.209693466959;14514.201718905562;14564.053336533092;14591.635209119857;36007.27985440329;36014.8199259002;36724.63275367212;36923.44614830726;38066.61933380631;47638.523614764796;48154.759226205046;50938.74530627323;51278.74360628173;52070;4678.60231880294;5822.854428639318;7316.670749816165;7515.6242187891485;7634.083909930844;10699.358038517714;11498.25261358009;11539.192256542297;11574.363410012531;11812.055035596959;10145.9492702536;10208.438535880598;10215.540300686338;10458.26792124544;10476.58093676275;9932.900670993487;10336.379817210991;10342.172626189737;10465.895341046493;10474.423906685206;10339.948300258451;10346.793064138525;10412.947935260276;10555.313904596176;10567.841482377617;7260.96369518149;7452.254774522505;7543.622818858926;7656.349210317186;7701.037370328709;9521.714348569554;9861.852072218779;10198.643047493302;10249;10279 04:42:35 INFO - PROCESS | 5389 | |3;mootools.html;1225.9877401225986;1340.9999999999998;1389.465055953458;1394.5676840179544;1690.76329313896;6891.414229790467;7655.885161722578;7939.761807145795;7942.324902383304;8139.145389734082;7955.284024437799;8040.8793868092025;8044.637991290391;8047.35621150308;8054.91945080549;2156.4608847788013;2191.846570740041;2192.6053310404122;2194.846360754748;2195.6816261642134;2137.1451419432196;2177.357679484548;2192.9342119736434;2194.9231776887814;2200.449887528118;2184.8907554622283;2189.255653077961;2200.526886719355;2200.6698995150778;2217.84475086744;2112.4402033461147;2113.8625989310644;2117.1002324012234;2121.257559854039;2125.9255926042592;2106.8630539015066;2148.763636000039;2152.35429371188;2153.5262242306667;2159.9568008639894;7725.150233474314;7895.210478952116;7995.880061799077;8047;8048.597570121529;4426.84506042287;4619.076184763061;4619.353290539327;4623.491415944243;4624.514425985257;2835.801493895428;2923.6199294091844;2968.391479746647;2974.881004759807;2976.255936015996;840.8360369727906;850.7447765670274;862.8231212601402;865.1651156633878;870.7257213977576;10893.07408870247;11011.229213955026;11031.72420689481;11047.889521104766;11049.668509944715;3788;3979.2638361902564;4002.219567184371;4091.488563929509;4111.76647005897;8587.656493740305;8617.48295102296;8617.78455538604;8619.051904290523;8619.138086191331;4513.50351461339;4522.29904364824;4522.728636281834;4526.275795872644;4529.728216307032;3729.813509324523;3839.8080095995088;4108.36320370343;4193.706440549132;4216.47294088239;3311.8012919224925;3351.614564325134;3427.246005878703;3435.57055368079;3455.3089382123676;967.2455484721928;978.9070038346346;982.4841957971979;989.4904124375952;1000.8798944126752;673.9224989126313;743.8846978718308;805.4844899264475;827.4485339987524;845.9534725590029;5066.771995260222;5106.668066575735;5283.52448279649;5319.281896943863;5353.946460535422;354.16593921314933;359.740986489727;359.87044663920966;360.7078266604059;375.76139151638904;3383.8477268522975;3463.1342164458883;3468.289000754839;3492.9126771830397;3633.9091522711615;9544.95227523858;9950.45272510019;9974.750631234132;9986.850197247048;10007.299489035844;9881.061299176567;9921.40471571708;9921.702348929544;9931.65239216624;9934.552945117486;7271.63641817907;7389.81525461857;7448.441366897396;7459.254074592606;7460.738874139379;5076.36545431821;5184.092783762751;5301.6818990860675;5329.733513324396;5408.5673146149;8886.955565222133;9061.048589897966;9062.456252624863;9079.818403632022;9149.77125571866;9226.308026898143;9255.35212535116;9277.350585459222;9293.070692930653;9301.116393942564;5787.061334452837;5952.970235148797;6272.40412160844;6339.366063393623;6341.460975817107;7336.266373362834;7441.330280274801;7524.623768811428;7704.075510938723;7711.8843217352905;6602.867942641216;6647.767328143492;6721.697523611351;6794.422474089758;6892.724291028303;6150.630962142286;6228.781992630236;6256.749730010749;6597.2742998271115;6665.466762658879;6282.371762823681;6351.841203969938;6353.5870168438905;6357.332480089524;6391.424771770563;4278.122984788049;4368.759718215529;4391.385206071089;4452.0205554777895;4489.34904438861;4355.89110272233;4431.8448854289945;4462.799174037111;4507.5943165115295;4546.318052292183 04:42:35 INFO - PROCESS | 5389 | |4;prototype.html;296.8560248279584;297.1071928853794;306.0710742895312;307.22885557251294;308.7591678490778;4834.516548345164;4865.245886887529;4874.48817874123;4880.9256066171865;4899.191633380488;4815;4819.855404337866;4841.491643377448;4844.709317440956;4844.781984810683;3625.546806649169;3722.8510859565586;3740.3267411865854;3806.181670940747;3847.5960024197475;3823.541175058997;3834.9424758628643;3836.693064554829;3843.4619153318417;3868.516435445569;3792.3742582473997;3796.8291426885858;3797.2215695782297;3797.468354430382;3816.580176180632;3591.8685614031497;3707.369747142965;3726.6646001859826;3778.9433158502643;3818.198178382543;3393.33829903169;3397.11674964511;3398.1164897126678;3398.1844357354057;3402.302527981758;4664.717202769266;4727.7163370197895;4728.810847566093;4729;4742.454617718972;4194.790260486994;4320.805563749639;4341.891452713676;4343.087951530182;4350.8042138103865;4991.376077990251;5000.374953130859;5001.974990125026;5009.824656137018;5014.047331007097;3696.667299942991;3697.020289623225;3701.7223708221723;3714.8699795507027;3721.6836568891677;5080.923786143211;5259.316288882497;5266.4733526647415;5271.710055946922;5290.074237008508;3730.54508741591;3736.4955730976512;3741.7193710471824;3767.547894252707;3778.809674952381;3764.698824094066;3786.8106594670157;3794.298054859805;3830.636089571486;3858.9228215436096;4338.6312163466455;4347.891302717458;4360.629346505519;4364.498082720528;4383.364412160219;4775.641826863;4932.53140951609;4949.455559888409;4984.975075124674;5001.5498605124985;1308.4177540994167;1336.4720935230723;1336.5722968649939;1337.3513845784787;1344.7512210241136;835.8006261015341;857.2756021162108;872.1583671756658;877.5651809291726;887.4763889305341;4295.183915056129;4329.718568293051;4424.070945101565;4428.911421771547;4438.048697616114;5198.506141916512;5224.357693690805;5225.268462415265;5230.189320655304;5246.7638956247065;4433.179861725526;4451.796360801424;4455.9554404456185;4456.532064133284;4462.955370446319;2621.84268943864;2762.48893954615;2792;2792.6229958955687;2797.4405118976288;4898.579411970489;4901;4908.9263661045115;4909.729964851967;4911.877203069952;5208.322918020633;5277.683338999673;5372.865678358073;5380.7309634518115;5405.972970135203;4796.136695394863;4824.469308376146;4836.347093142451;4851.320815085891;4914.778834952435;5167.431582525844;5183.714895680774;5192.324997750419;5201.92197117036;5204.609654276021;4928.383952005999;5067.923981140212;5106.923396149135;5127.512886275797;5133.281340612242;4871.953779412726;4876.146674332049;4876.487968763229;4882.194437917846;4883.291922671264;3369.9663003370633;3377.67912048355;3381.9661803382637;3394.6435624259097;3401.2007178312583;4472.635846066851;4678.251479763221;4678.368420263221;4697.530246975275;4710.528947105262;4519.954800451954;4520.547945205453;4528.43394575678;4529.139463501924;4541.977290113528;4488.483824360241;4520.344550040291;4528.43394575678;4549.545045495424;4572.268437050056;4486.551344865487;4487.6185524230805;4501.639868810553;4509.594136527729;4537.617750680919;4671.369365135663;4761.309610106585;5122.4910936008955;5179.585633149414;5192.870178245574;5054.16606259963;5059.443461219189;5073.797048118034;5084.01723327895;5085.516875896784 04:42:35 INFO - PROCESS | 5389 | |5;yui.html;554.805817963713;594.8156071617797;602.5169179627211;679.9864002719946;718.1705130574186;11416.200865939387;12161.756764864698;12164.574239901605;12182.390880455974;12185.878141218585;11564.826527602092;11652.417379131031;11685.240459370136;11725.355105469196;11732;624.1199908129538;630.6310808177221;745.4818900863888;752.5183882315323;758.5600351795973;773.0954782904016;773.2576726342689;773.5165521549031;773.6402572803645;774.9186335434782;806.9798255043612;809.3929552835374;810.6109067647533;810.9878351824727;811.253646645085;655.4101308822075;665.9700313485905;777.747232149548;794.8370584030259;805.2913436176157;594.7829042399536;595.4194660206308;595.5682130455428;595.7348979703991;595.8569943213641;11839.881601183964;11862.406879655982;11887.227330223594;11897.167198296123;11907.464164112636;12772.680682982907;13150.539731109366;13483.460661573525;13505.729885402237;13557.661058473519;11739.530418783239;11775.941120294343;11870.109741769402;11914.582989595323;12133.453994570265;4087.5955933870837;4106.342985122366;4110.23960567293;4170.979145104286;4178.603032711888;53030.46969530294;55035.69785812864;55104.448955510336;63278.68360658213;65592;9934.701958941243;10001.699949001542;10118.747031324128;10289.74275643115;10428.217883658755;18628.72056919147;18628.906855465637;18628.906855465637;18635.90682046581;18643.161057752433;6338.904916426257;6367.108604795332;6439.259485159267;6607.372299631527;6772.051912732221;3476.878309259164;3509.0876372142916;3523.894283171509;3627.056965189017;3695.6858667013066;3051;3231.563738895266;3257.820819854931;3265.053134590942;3270.8037517749012;551.1952549278019;554.0166204986182;559.1361346719328;560.3863769172749;564.7627996241588;439.87903326585445;520.4431258553311;545.0135255188122;576.3602401334515;579.4205794205794;7499.512531685423;7872.685092596232;7909.604519773989;7915.683372665029;7981.68073277074;509.85214287856104;553.8006317725616;570.2700543304577;580.4021857486796;588.7880363069291;3672.3756961316108;3850.3839385698716;3906.7655940643654;3971.543272523639;3976.940345894814;102573.48713256535;102906;104035;104068;107011;86421.56789216014;87353;87771.56114219388;89253;91203.54398228099;72228.63885680643;78484.60757696175;78495;79111.60444197858;79211.20788792154;7325.706971721072;7442.1441534222095;7488.887666685113;7849.960750196213;7882.881756773768;45556.54443455523;45627.54372456366;45997.77001114973;46341.53658463507;46342.76828615835;37953;46550.30174547317;51075.48924510707;53725.462745372046;55306.72346638241;10798.190135739695;10946.507407166855;11505.827412588651;11627.186096973131;12155.331456769962;12144.939275303566;12495.562655307021;12909.806352904527;13381.53164639233;13617.65955851072;10835.566577337133;11271.605493807678;11509.424528773696;11771;11983.820242696542;11439;11878.584249551224;12243.571474998333;12253.816192756938;12614.306213158365;11158.944205278922;11411.429428528374;11501.309921404743;11583.594574189863;11641.359725214856;9595.856062159213;9697.315020292244;9794.559244834141;9988.153376287722;10119.190464762949;9098.860018691346;10139.138173255356;10184.388936663823;10241.180705543688;10307.226957978031 04:42:35 INFO - PROCESS | 5389 | __end_tp_report 04:42:35 INFO - PROCESS | 5389 | __start_cc_report 04:42:35 INFO - PROCESS | 5389 | _x_x_mozilla_cycle_collect,975 04:42:35 INFO - PROCESS | 5389 | __end_cc_report 04:42:35 INFO - PROCESS | 5389 | __startTimestamp1474976555149__endTimestamp 04:42:35 INFO - PROCESS | 5389 | 04:42:35 INFO - PROCESS | 5389 | ------- Summary: start ------- 04:42:35 INFO - PROCESS | 5389 | Number of tests: 6 04:42:35 INFO - PROCESS | 5389 | 04:42:35 INFO - PROCESS | 5389 | [#0] dojo.html Cycles:165 Average:4700.11 Median:4806.57 stddev:493.79 (10.3%) stddev-sans-first:466.18 04:42:35 INFO - PROCESS | 5389 | Values: 2570.2 2613.5 2640.7 2649.7 2661.7 4628.2 4688.7 4730.6 4768.1 4772.6 4676.0 4703.0 4722.5 4735.4 4806.6 4310.6 4331.1 4362.1 4366.9 4390.5 4409.4 4412.0 4440.6 4442.7 4488.8 4387.7 4418.0 4432.5 4433.9 4473.6 4184.9 4220.2 4221.1 4347.4 4392.4 4302.8 4304.1 4314.0 4421.0 4427.8 4726.6 4746.5 4748.0 4783.5 4826.2 4884.4 4974.9 5046.0 5095.9 5105.9 5127.6 5136.2 5142.6 5143.3 5190.4 4777.1 4791.6 4794.4 4798.5 4845.1 5101.1 5155.8 5175.4 5240.9 5300.5 5005.6 5022.3 5024.9 5077.3 5089.3 5094.8 5102.8 5105.9 5109.8 5179.2 4902.6 4974.2 5052.3 5052.8 5060.1 4947.7 4959.0 4994.1 5008.6 5012.1 4359.7 4375.3 4378.5 4397.8 4424.7 3775.4 3777.7 3782.0 3823.5 3869.8 4313.3 4370.4 4379.4 4420.1 4430.8 4972.6 4979.5 5013.1 5036.8 5164.5 4342.2 4345.5 4384.2 4399.2 4403.4 4572.8 4584.2 4585.0 4587.7 4641.7 4610.5 4663.0 4741.4 4752.4 4761.7 5082.1 5118.4 5122.3 5152.9 5190.2 4759.8 4778.1 4778.9 4782.2 4834.3 4894.5 4953.8 5074.6 5082.2 5145.5 5040.2 5070.1 5083.2 5093.1 5152.5 4954.3 4961.7 4964.1 4968.3 5028.4 4849.9 4927.4 4964.4 4975.2 5031.5 4841.8 4865.8 4938.8 4944.1 5014.6 5048.0 5052.4 5067.5 5071.9 5073.7 4778.2 4836.4 4842.1 4930.0 4942.1 04:42:35 INFO - PROCESS | 5389 | 04:42:35 INFO - PROCESS | 5389 | [#1] ext.html Cycles:180 Average:51176.75 Median:36766.72 stddev:101103.02 (275.0%) stddev-sans-first:101315.23 04:42:35 INFO - PROCESS | 5389 | Values: 565.3 574.3 575.2 576.5 581.8 28440.4 31409.5 31427.0 37972.2 39244.6 39766.0 40169.0 40182.2 40229.8 40304.4 7546.4 7670.8 7688.2 7701.2 7702.2 7341.9 7519.5 7528.4 7603.8 7828.7 7338.5 10070.3 10394.8 10415.6 10416.0 9891.8 9968.6 9973.6 9976.9 9980.6 9629.6 9712.1 9713.5 9713.8 9722.2 38702.6 38944.0 38962.8 39044.4 39097.6 2838.2 3043.5 3044.9 3109.6 3263.7 28373.6 28393.0 28514.3 28939.9 29864.9 3425.3 3471.7 3508.1 3508.9 3558.4 261024.0 261067.0 261812.0 261972.0 263569.0 51775.2 52184.5 52190.5 52241.5 52321.2 31898.7 33012.5 33051.8 35099.0 35101.6 13923.2 14116.3 14118.6 14118.9 14119.3 10237.7 10288.5 10291.6 10292.9 10302.9 15415.8 15730.0 16887.4 17230.0 17336.8 6577.3 6592.0 6677.3 6938.7 7110.7 792.3 890.6 896.8 956.4 1010.7 27675.9 28051.4 28203.1 28646.4 28844.7 938.8 954.8 983.8 992.3 998.8 14579.0 15120.5 15195.2 15213.3 15251.9 370070.0 374424.0 375319.0 375406.0 375648.0 43572.6 44288.8 44345.3 50469.0 52958.5 1059.5 1172.4 1199.7 1207.8 1210.5 27641.7 29075.7 29835.0 30159.0 30181.0 43130.4 43345.7 43398.1 43408.8 43533.8 377838.0 387195.0 387946.0 585129.0 589775.0 38127.8 38548.4 38566.0 38724.2 39423.2 41987.4 42187.0 42197.6 42366.6 43237.0 34997.3 35395.5 35415.6 35642.3 35661.5 36167.0 36710.3 36764.8 36768.6 36908.6 35827.8 35831.6 35952.8 35997.6 36327.0 31092.5 31571.0 32580.1 33155.3 35403.0 25330.7 25734.5 25837.6 25947.2 25985.4 04:42:35 INFO - PROCESS | 5389 | 04:42:35 INFO - PROCESS | 5389 | [#2] jquery.html Cycles:180 Average:23368.19 Median:47896.64 stddev:61506.71 (128.4%) stddev-sans-first:61654.96 04:42:35 INFO - PROCESS | 5389 | Values: 343.7 360.7 366.6 370.2 381.9 12484.9 15677.5 15739.1 16189.4 17076.4 16457.4 16576.2 16611.8 16872.8 16982.9 4859.3 5062.4 5157.3 5363.4 5417.9 3378.1 5391.4 5430.8 5440.9 5449.0 3498.6 5135.6 5332.1 5377.9 5480.5 5427.0 5478.3 5483.4 5487.9 5912.6 5255.9 5257.3 5258.7 5262.1 5278.8 12012.8 12208.9 18384.9 19035.4 19168.1 1888.8 2075.0 2127.7 2271.5 2339.2 8807.8 8843.6 8966.7 9127.7 9146.0 1610.4 1648.6 1652.0 1762.9 1765.4 67386.0 69229.7 70091.3 70490.6 71497.0 8971.4 9018.2 9110.9 9225.2 9555.0 12872.4 12888.2 12888.5 12925.6 12937.2 6415.8 6539.3 6544.2 6554.5 6794.9 6078.4 6117.5 6127.2 6214.9 6448.3 4009.5 4077.2 4157.6 4168.4 4299.6 1696.6 1716.7 1720.6 1775.3 1783.5 862.3 871.0 877.0 899.1 929.5 15173.3 15629.0 15828.6 16607.3 17012.5 826.0 828.5 837.8 845.7 896.6 8753.2 9272.9 9291.4 9324.4 9450.4 368489.0 371835.0 372054.0 372098.0 372836.0 73378.0 75001.0 76440.0 77464.6 78646.6 851.4 870.0 870.5 870.7 874.1 14188.4 14369.2 14514.2 14564.1 14591.6 36007.3 36014.8 36724.6 36923.4 38066.6 47638.5 48154.8 50938.7 51278.7 52070.0 4678.6 5822.9 7316.7 7515.6 7634.1 10699.4 11498.3 11539.2 11574.4 11812.1 10145.9 10208.4 10215.5 10458.3 10476.6 9932.9 10336.4 10342.2 10465.9 10474.4 10339.9 10346.8 10412.9 10555.3 10567.8 7261.0 7452.3 7543.6 7656.3 7701.0 9521.7 9861.9 10198.6 10249.0 10279.0 04:42:35 INFO - PROCESS | 5389 | 04:42:35 INFO - PROCESS | 5389 | [#3] mootools.html Cycles:180 Average:5096.70 Median:5233.81 stddev:2968.59 (56.7%) stddev-sans-first:2962.67 04:42:35 INFO - PROCESS | 5389 | Values: 1226.0 1341.0 1389.5 1394.6 1690.8 6891.4 7655.9 7939.8 7942.3 8139.1 7955.3 8040.9 8044.6 8047.4 8054.9 2156.5 2191.8 2192.6 2194.8 2195.7 2137.1 2177.4 2192.9 2194.9 2200.4 2184.9 2189.3 2200.5 2200.7 2217.8 2112.4 2113.9 2117.1 2121.3 2125.9 2106.9 2148.8 2152.4 2153.5 2160.0 7725.2 7895.2 7995.9 8047.0 8048.6 4426.8 4619.1 4619.4 4623.5 4624.5 2835.8 2923.6 2968.4 2974.9 2976.3 840.8 850.7 862.8 865.2 870.7 10893.1 11011.2 11031.7 11047.9 11049.7 3788.0 3979.3 4002.2 4091.5 4111.8 8587.7 8617.5 8617.8 8619.1 8619.1 4513.5 4522.3 4522.7 4526.3 4529.7 3729.8 3839.8 4108.4 4193.7 4216.5 3311.8 3351.6 3427.2 3435.6 3455.3 967.2 978.9 982.5 989.5 1000.9 673.9 743.9 805.5 827.4 846.0 5066.8 5106.7 5283.5 5319.3 5353.9 354.2 359.7 359.9 360.7 375.8 3383.8 3463.1 3468.3 3492.9 3633.9 9545.0 9950.5 9974.8 9986.9 10007.3 9881.1 9921.4 9921.7 9931.7 9934.6 7271.6 7389.8 7448.4 7459.3 7460.7 5076.4 5184.1 5301.7 5329.7 5408.6 8887.0 9061.0 9062.5 9079.8 9149.8 9226.3 9255.4 9277.4 9293.1 9301.1 5787.1 5953.0 6272.4 6339.4 6341.5 7336.3 7441.3 7524.6 7704.1 7711.9 6602.9 6647.8 6721.7 6794.4 6892.7 6150.6 6228.8 6256.7 6597.3 6665.5 6282.4 6351.8 6353.6 6357.3 6391.4 4278.1 4368.8 4391.4 4452.0 4489.3 4355.9 4431.8 4462.8 4507.6 4546.3 04:42:35 INFO - PROCESS | 5389 | 04:42:35 INFO - PROCESS | 5389 | [#4] prototype.html Cycles:180 Average:4145.13 Median:4528.79 stddev:1182.65 (26.1%) stddev-sans-first:1150.15 04:42:35 INFO - PROCESS | 5389 | Values: 296.9 297.1 306.1 307.2 308.8 4834.5 4865.2 4874.5 4880.9 4899.2 4815.0 4819.9 4841.5 4844.7 4844.8 3625.5 3722.9 3740.3 3806.2 3847.6 3823.5 3834.9 3836.7 3843.5 3868.5 3792.4 3796.8 3797.2 3797.5 3816.6 3591.9 3707.4 3726.7 3778.9 3818.2 3393.3 3397.1 3398.1 3398.2 3402.3 4664.7 4727.7 4728.8 4729.0 4742.5 4194.8 4320.8 4341.9 4343.1 4350.8 4991.4 5000.4 5002.0 5009.8 5014.0 3696.7 3697.0 3701.7 3714.9 3721.7 5080.9 5259.3 5266.5 5271.7 5290.1 3730.5 3736.5 3741.7 3767.5 3778.8 3764.7 3786.8 3794.3 3830.6 3858.9 4338.6 4347.9 4360.6 4364.5 4383.4 4775.6 4932.5 4949.5 4985.0 5001.5 1308.4 1336.5 1336.6 1337.4 1344.8 835.8 857.3 872.2 877.6 887.5 4295.2 4329.7 4424.1 4428.9 4438.0 5198.5 5224.4 5225.3 5230.2 5246.8 4433.2 4451.8 4456.0 4456.5 4463.0 2621.8 2762.5 2792.0 2792.6 2797.4 4898.6 4901.0 4908.9 4909.7 4911.9 5208.3 5277.7 5372.9 5380.7 5406.0 4796.1 4824.5 4836.3 4851.3 4914.8 5167.4 5183.7 5192.3 5201.9 5204.6 4928.4 5067.9 5106.9 5127.5 5133.3 4872.0 4876.1 4876.5 4882.2 4883.3 3370.0 3377.7 3382.0 3394.6 3401.2 4472.6 4678.3 4678.4 4697.5 4710.5 4520.0 4520.5 4528.4 4529.1 4542.0 4488.5 4520.3 4528.4 4549.5 4572.3 4486.6 4487.6 4501.6 4509.6 4537.6 4671.4 4761.3 5122.5 5179.6 5192.9 5054.2 5059.4 5073.8 5084.0 5085.5 04:42:35 INFO - PROCESS | 5389 | 04:42:35 INFO - PROCESS | 5389 | [#5] yui.html Cycles:180 Average:17629.68 Median:22998.21 stddev:25774.80 (112.1%) stddev-sans-first:25815.22 04:42:35 INFO - PROCESS | 5389 | Values: 554.8 594.8 602.5 680.0 718.2 11416.2 12161.8 12164.6 12182.4 12185.9 11564.8 11652.4 11685.2 11725.4 11732.0 624.1 630.6 745.5 752.5 758.6 773.1 773.3 773.5 773.6 774.9 807.0 809.4 810.6 811.0 811.3 655.4 666.0 777.7 794.8 805.3 594.8 595.4 595.6 595.7 595.9 11839.9 11862.4 11887.2 11897.2 11907.5 12772.7 13150.5 13483.5 13505.7 13557.7 11739.5 11775.9 11870.1 11914.6 12133.5 4087.6 4106.3 4110.2 4171.0 4178.6 53030.5 55035.7 55104.4 63278.7 65592.0 9934.7 10001.7 10118.7 10289.7 10428.2 18628.7 18628.9 18628.9 18635.9 18643.2 6338.9 6367.1 6439.3 6607.4 6772.1 3476.9 3509.1 3523.9 3627.1 3695.7 3051.0 3231.6 3257.8 3265.1 3270.8 551.2 554.0 559.1 560.4 564.8 439.9 520.4 545.0 576.4 579.4 7499.5 7872.7 7909.6 7915.7 7981.7 509.9 553.8 570.3 580.4 588.8 3672.4 3850.4 3906.8 3971.5 3976.9 102573.5 102906.0 104035.0 104068.0 107011.0 86421.6 87353.0 87771.6 89253.0 91203.5 72228.6 78484.6 78495.0 79111.6 79211.2 7325.7 7442.1 7488.9 7850.0 7882.9 45556.5 45627.5 45997.8 46341.5 46342.8 37953.0 46550.3 51075.5 53725.5 55306.7 10798.2 10946.5 11505.8 11627.2 12155.3 12144.9 12495.6 12909.8 13381.5 13617.7 10835.6 11271.6 11509.4 11771.0 11983.8 11439.0 11878.6 12243.6 12253.8 12614.3 11158.9 11411.4 11501.3 11583.6 11641.4 9595.9 9697.3 9794.6 9988.2 10119.2 9098.9 10139.1 10184.4 10241.2 10307.2 04:42:35 INFO - PROCESS | 5389 | -------- Summary: end -------- 04:42:35 INFO - PROCESS | 5389 | 04:42:36 INFO - TEST-INFO | 5389: exit 0 04:42:36 INFO - TEST-OK | dromaeo_css | took 1121396ms 04:42:36 INFO - TEST-START | kraken 04:42:36 INFO - operating with platform_type : linux_ 04:42:36 INFO - Initialising browser for kraken test... 04:42:36 INFO - TEST-INFO | started process 5694 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzOjSWy/profile http://localhost:40833/getInfo.html) 04:42:40 INFO - PROCESS | 5694 | __metrics Screen width/height:1600/1200 04:42:40 INFO - PROCESS | 5694 | colorDepth:24 04:42:40 INFO - PROCESS | 5694 | Browser inner width/height: 1024/697 04:42:40 INFO - PROCESS | 5694 | __metrics 04:42:41 INFO - PROCESS | 5694 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:42:41 INFO - PROCESS | 5694 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:42:41 INFO - PROCESS | 5694 | console.error: PushService: 04:42:41 INFO - PROCESS | 5694 | stateChangeProcessEnqueue: Error transitioning state 04:42:41 INFO - PROCESS | 5694 | UnknownError 04:42:42 INFO - TEST-INFO | 5694: exit 0 04:42:42 INFO - Browser initialized. 04:42:42 INFO - Running cycle 1/1 for kraken test... 04:42:42 INFO - TEST-INFO | started process 5777 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzOjSWy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:42:54 INFO - PROCESS | 5777 | RSS: Main: 175534080 04:42:54 INFO - PROCESS | 5777 | 04:42:57 INFO - PROCESS | 5777 | Cycle 1(1): loaded http://localhost:40833/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40833/tests/kraken/driver.html?testName=audio-beat-detection) 04:42:58 INFO - PROCESS | 5777 | RSS: Main: 234127360 04:42:58 INFO - PROCESS | 5777 | 04:43:01 INFO - PROCESS | 5777 | Cycle 1(1): loaded http://localhost:40833/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40833/tests/kraken/driver.html?testName=audio-dft) 04:43:01 INFO - PROCESS | 5777 | RSS: Main: 218722304 04:43:01 INFO - PROCESS | 5777 | 04:43:05 INFO - PROCESS | 5777 | Cycle 1(1): loaded http://localhost:40833/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40833/tests/kraken/driver.html?testName=audio-fft) 04:43:05 INFO - PROCESS | 5777 | RSS: Main: 300875776 04:43:05 INFO - PROCESS | 5777 | 04:43:07 INFO - PROCESS | 5777 | Cycle 1(1): loaded http://localhost:40833/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40833/tests/kraken/driver.html?testName=audio-oscillator) 04:43:08 INFO - PROCESS | 5777 | RSS: Main: 210403328 04:43:08 INFO - PROCESS | 5777 | 04:43:10 INFO - PROCESS | 5777 | Cycle 1(1): loaded http://localhost:40833/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40833/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:43:11 INFO - PROCESS | 5777 | RSS: Main: 214196224 04:43:11 INFO - PROCESS | 5777 | 04:43:14 INFO - PROCESS | 5777 | Cycle 1(1): loaded http://localhost:40833/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40833/tests/kraken/driver.html?testName=imaging-darkroom) 04:43:15 INFO - PROCESS | 5777 | RSS: Main: 251432960 04:43:15 INFO - PROCESS | 5777 | 04:43:18 INFO - PROCESS | 5777 | Cycle 1(1): loaded http://localhost:40833/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40833/tests/kraken/driver.html?testName=imaging-desaturate) 04:43:19 INFO - PROCESS | 5777 | RSS: Main: 244965376 04:43:19 INFO - PROCESS | 5777 | 04:43:22 INFO - PROCESS | 5777 | Cycle 1(1): loaded http://localhost:40833/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40833/tests/kraken/driver.html?testName=json-parse-financial) 04:43:22 INFO - PROCESS | 5777 | RSS: Main: 247922688 04:43:22 INFO - PROCESS | 5777 | 04:43:24 INFO - PROCESS | 5777 | Cycle 1(1): loaded http://localhost:40833/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40833/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:43:25 INFO - PROCESS | 5777 | RSS: Main: 211324928 04:43:25 INFO - PROCESS | 5777 | 04:43:26 INFO - PROCESS | 5777 | Cycle 1(1): loaded http://localhost:40833/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40833/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:43:27 INFO - PROCESS | 5777 | RSS: Main: 218353664 04:43:27 INFO - PROCESS | 5777 | 04:43:29 INFO - PROCESS | 5777 | Cycle 1(1): loaded http://localhost:40833/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40833/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:43:30 INFO - PROCESS | 5777 | RSS: Main: 222691328 04:43:30 INFO - PROCESS | 5777 | 04:43:33 INFO - PROCESS | 5777 | Cycle 1(1): loaded http://localhost:40833/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40833/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:43:33 INFO - PROCESS | 5777 | RSS: Main: 223457280 04:43:33 INFO - PROCESS | 5777 | 04:43:36 INFO - PROCESS | 5777 | Cycle 1(1): loaded http://localhost:40833/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40833/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:43:37 INFO - PROCESS | 5777 | RSS: Main: 222216192 04:43:37 INFO - PROCESS | 5777 | 04:43:39 INFO - PROCESS | 5777 | Cycle 1(1): loaded http://localhost:40833/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40833/tests/kraken/driver.html?testName=ai-astar) 04:43:39 INFO - PROCESS | 5777 | RSS: Main: 272998400 04:43:39 INFO - PROCESS | 5777 | 04:43:39 INFO - PROCESS | 5777 | __start_tp_report 04:43:39 INFO - PROCESS | 5777 | _x_x_mozilla_page_load 04:43:39 INFO - PROCESS | 5777 | _x_x_mozilla_page_load_details 04:43:39 INFO - PROCESS | 5777 | |i|pagename|runs| 04:43:39 INFO - PROCESS | 5777 | |0;ai-astar;111;113;115;114;114;114;113;113;114;113 04:43:39 INFO - PROCESS | 5777 | |1;audio-beat-detection;157;124;122;173;127;125;131;123;155;124 04:43:39 INFO - PROCESS | 5777 | |2;audio-dft;163;163;162;162;161;161;163;162;161;162 04:43:39 INFO - PROCESS | 5777 | |3;audio-fft;77;76;76;111;77;76;76;76;126;76 04:43:39 INFO - PROCESS | 5777 | |4;audio-oscillator;85;85;115;84;85;85;105;84;85;113 04:43:39 INFO - PROCESS | 5777 | |5;imaging-gaussian-blur;116;117;117;117;117;117;116;116;117;116 04:43:39 INFO - PROCESS | 5777 | |6;imaging-darkroom;146;147;147;147;146;147;146;145;146;146 04:43:39 INFO - PROCESS | 5777 | |7;imaging-desaturate;96;97;96;96;96;96;96;96;96;96 04:43:39 INFO - PROCESS | 5777 | |8;json-parse-financial;62;62;62;63;64;63;64;63;63;63 04:43:39 INFO - PROCESS | 5777 | |9;json-stringify-tinderbox;67;66;68;66;67;66;66;67;66;66 04:43:39 INFO - PROCESS | 5777 | |10;stanford-crypto-aes;83;82;89;86;81;82;81;82;81;82 04:43:39 INFO - PROCESS | 5777 | |11;stanford-crypto-ccm;146;144;136;133;135;135;134;134;169;142 04:43:39 INFO - PROCESS | 5777 | |12;stanford-crypto-pbkdf2;176;173;173;178;177;174;177;181;174;172 04:43:39 INFO - PROCESS | 5777 | |13;stanford-crypto-sha256-iterative;68;70;68;70;75;70;70;69;68;68 04:43:39 INFO - PROCESS | 5777 | __end_tp_report 04:43:39 INFO - PROCESS | 5777 | __start_cc_report 04:43:39 INFO - PROCESS | 5777 | _x_x_mozilla_cycle_collect,1937 04:43:39 INFO - PROCESS | 5777 | __end_cc_report 04:43:39 INFO - PROCESS | 5777 | __startTimestamp1474976619536__endTimestamp 04:43:39 INFO - PROCESS | 5777 | 04:43:39 INFO - PROCESS | 5777 | ------- Summary: start ------- 04:43:39 INFO - PROCESS | 5777 | Number of tests: 14 04:43:39 INFO - PROCESS | 5777 | 04:43:39 INFO - PROCESS | 5777 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:1.07 (0.9%) stddev-sans-first:0.71 04:43:39 INFO - PROCESS | 5777 | Values: 111.0 113.0 115.0 114.0 114.0 114.0 113.0 113.0 114.0 113.0 04:43:39 INFO - PROCESS | 5777 | 04:43:39 INFO - PROCESS | 5777 | [#1] audio-beat-detection Cycles:10 Average:136.10 Median:129.00 stddev:18.41 (14.3%) stddev-sans-first:17.91 04:43:39 INFO - PROCESS | 5777 | Values: 157.0 124.0 122.0 173.0 127.0 125.0 131.0 123.0 155.0 124.0 04:43:39 INFO - PROCESS | 5777 | 04:43:39 INFO - PROCESS | 5777 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 04:43:39 INFO - PROCESS | 5777 | Values: 163.0 163.0 162.0 162.0 161.0 161.0 163.0 162.0 161.0 162.0 04:43:39 INFO - PROCESS | 5777 | 04:43:39 INFO - PROCESS | 5777 | [#3] audio-fft Cycles:10 Average:84.70 Median:76.00 stddev:18.17 (23.9%) stddev-sans-first:19.05 04:43:39 INFO - PROCESS | 5777 | Values: 77.0 76.0 76.0 111.0 77.0 76.0 76.0 76.0 126.0 76.0 04:43:39 INFO - PROCESS | 5777 | 04:43:39 INFO - PROCESS | 5777 | [#4] audio-oscillator Cycles:10 Average:92.60 Median:85.00 stddev:12.95 (15.2%) stddev-sans-first:13.44 04:43:39 INFO - PROCESS | 5777 | Values: 85.0 85.0 115.0 84.0 85.0 85.0 105.0 84.0 85.0 113.0 04:43:39 INFO - PROCESS | 5777 | 04:43:39 INFO - PROCESS | 5777 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 04:43:39 INFO - PROCESS | 5777 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 116.0 04:43:39 INFO - PROCESS | 5777 | 04:43:39 INFO - PROCESS | 5777 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 04:43:39 INFO - PROCESS | 5777 | Values: 146.0 147.0 147.0 147.0 146.0 147.0 146.0 145.0 146.0 146.0 04:43:39 INFO - PROCESS | 5777 | 04:43:39 INFO - PROCESS | 5777 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:43:39 INFO - PROCESS | 5777 | Values: 96.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 04:43:39 INFO - PROCESS | 5777 | 04:43:39 INFO - PROCESS | 5777 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:63.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 04:43:39 INFO - PROCESS | 5777 | Values: 62.0 62.0 62.0 63.0 64.0 63.0 64.0 63.0 63.0 63.0 04:43:39 INFO - PROCESS | 5777 | 04:43:39 INFO - PROCESS | 5777 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:66.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 04:43:39 INFO - PROCESS | 5777 | Values: 67.0 66.0 68.0 66.0 67.0 66.0 66.0 67.0 66.0 66.0 04:43:39 INFO - PROCESS | 5777 | 04:43:39 INFO - PROCESS | 5777 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:82.00 stddev:2.60 (3.2%) stddev-sans-first:2.76 04:43:39 INFO - PROCESS | 5777 | Values: 83.0 82.0 89.0 86.0 81.0 82.0 81.0 82.0 81.0 82.0 04:43:39 INFO - PROCESS | 5777 | 04:43:39 INFO - PROCESS | 5777 | [#11] stanford-crypto-ccm Cycles:10 Average:140.80 Median:139.00 stddev:10.94 (7.9%) stddev-sans-first:11.44 04:43:39 INFO - PROCESS | 5777 | Values: 146.0 144.0 136.0 133.0 135.0 135.0 134.0 134.0 169.0 142.0 04:43:39 INFO - PROCESS | 5777 | 04:43:39 INFO - PROCESS | 5777 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.50 Median:176.50 stddev:2.80 (1.6%) stddev-sans-first:2.96 04:43:39 INFO - PROCESS | 5777 | Values: 176.0 173.0 173.0 178.0 177.0 174.0 177.0 181.0 174.0 172.0 04:43:39 INFO - PROCESS | 5777 | 04:43:39 INFO - PROCESS | 5777 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:70.00 stddev:2.12 (3.0%) stddev-sans-first:2.17 04:43:39 INFO - PROCESS | 5777 | Values: 68.0 70.0 68.0 70.0 75.0 70.0 70.0 69.0 68.0 68.0 04:43:39 INFO - PROCESS | 5777 | -------- Summary: end -------- 04:43:39 INFO - PROCESS | 5777 | 04:43:40 INFO - TEST-INFO | 5777: exit 0 04:43:41 INFO - TEST-OK | kraken | took 64826ms 04:43:41 INFO - SUITE-END | took 1186s 04:43:41 INFO - Completed test suite (00:19:46) 04:43:41 INFO - javascript benchmark 04:43:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2570.2032369965314, 2613.4773045390925, 2640.7227241139685, 2649.668791401075, 2661.7205193454674, 4628.1669299526075, 4688.695234809735, 4730.550597693222, 4768.070226305867, 4772.570468657825, 4676.0, 4703.035877645083, 4722.527747225276, 4735.3607263019485, 4806.567408933195, 4310.590493903074, 4331.112122014995, 4362.105768317503, 4366.890827729317, 4390.4511936008, 4409.360642706805, 4412.029353542232, 4440.555944405566, 4442.689011769177, 4488.842890498833, 4387.736735795863, 4417.977910110445, 4432.534583868695, 4433.889152771207, 4473.597376236138, 4184.853530126431, 4220.240356735786, 4221.134667393177, 4347.369631403429, 4392.428984232061, 4302.806373713191, 4304.074623955865, 4314.0, 4421.049474363027, 4427.800748966304, 4726.645501587394, 4746.5490778376, 4748.0, 4783.545563171493, 4826.155422801031, 4884.365032545782, 4974.90050198994, 5046.0, 5095.923561146586, 5105.872353191163, 5127.589792816566, 5136.229565565158, 5142.562882155022, 5143.27994080829, 5190.377154741455, 4777.06847164803, 4791.6406269529925, 4794.400699912511, 4798.520147985243, 4845.055214233191, 5101.056304583664, 5155.793768249303, 5175.404828444702, 5240.9213861792105, 5300.469953004668, 5005.649604527648, 5022.347094877642, 5024.899502009939, 5077.289179514871, 5089.262057001714, 5094.77073531692, 5102.821401250939, 5105.948940510547, 5109.795608175706, 5179.171332586768, 4902.632302577321, 4974.17926042199, 5052.292679024939, 5052.797888084509, 5060.063888180698, 4947.6536642434685, 4958.983408401269, 4994.076095922266, 5008.649394542347, 5012.072766538202, 4359.694821362475, 4375.256206444912, 4378.5183629800695, 4397.8240870364825, 4424.7123936944, 3775.3770627846648, 3777.697784177259, 3782.0, 3823.4647149399107, 3869.8258578364043, 4313.331433627793, 4370.38814565961, 4379.364992076131, 4420.115976804652, 4430.778461076933, 4972.577330926912, 4979.45226025137, 5013.072581572421, 5036.7733451994745, 5164.509371609691, 4342.1749867525705, 4345.456817897762, 4384.210842048462, 4399.208142534375, 4403.427554417905, 4572.817087316536, 4584.17484852723, 4585.037142200109, 4587.655925805578, 4641.675082744243, 4610.5389461054965, 4662.976685116552, 4741.431028276629, 4752.42970843501, 4761.738104404152, 5082.059818933509, 5118.360204974379, 5122.308488354024, 5152.948470515247, 5190.247414125006, 4759.76201189946, 4778.092162489255, 4778.928316075192, 4782.210935195653, 4834.274858771212, 4894.510548945077, 4953.7523123844385, 5074.619403544675, 5082.2122571001555, 5145.459726728789, 5040.218766091261, 5070.062038522885, 5083.161278389024, 5093.134167191661, 5152.458991805806, 4954.281629163823, 4961.652684312064, 4964.081644895706, 4968.254761785761, 5028.446870844277, 4849.878753031202, 4927.384076990376, 4964.379452568429, 4975.203967365204, 5031.52200540948, 4841.782119804688, 4865.781039853145, 4938.802447902043, 4944.060628480721, 5014.598832093497, 5048.040872234411, 5052.368453943257, 5067.543921047123, 5071.87320316995, 5073.720945348041, 4778.187708089703, 4836.395450568679, 4842.055799119138, 4929.950700493093, 4942.1104201244125], "value": 4668.295470840939, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.3103214078824, 574.3251679276849, 575.2004713448307, 576.5186069631857, 581.7731084876901, 28440.431191376185, 31409.528857067162, 31427.0, 37972.21569578237, 39244.607553924456, 39766.0, 40169.0, 40182.19635607286, 40229.798851005704, 40304.395434068436, 7546.358559522447, 7670.808229794272, 7688.231176882323, 7701.191374905638, 7702.191269916662, 7341.853162936738, 7519.473636845396, 7528.39772818176, 7603.847923041536, 7828.725994590191, 7338.486305958585, 10070.295079344449, 10394.844077338847, 10415.583376664925, 10416.0, 9891.752706182368, 9968.551415186334, 9973.601055957753, 9976.90023099767, 9980.550875210633, 9629.566669499889, 9712.077352651557, 9713.514324283828, 9713.805723885484, 9722.222222222204, 38702.612973870186, 38944.02639933996, 38962.805185974175, 39044.41433378502, 39097.60902390968, 2838.247864315958, 3043.5282531207476, 3044.9086527404215, 3109.6268447786183, 3263.6573159818113, 28373.574396384072, 28393.0, 28514.287142821388, 28939.85530072336, 29864.8506757467, 3425.3491836550975, 3471.687548120656, 3508.14050557615, 3508.8771892983877, 3558.4128618777872, 261024.0, 261067.0, 261812.0, 261972.0, 263568.9999999981, 51775.22337164945, 52184.47815521872, 52190.47809521856, 52241.47758522442, 52321.215181772306, 31898.681013190035, 33012.50481242783, 33051.83474082614, 35099.0, 35101.64898351035, 13923.164610123426, 14116.294185290695, 14118.647033824236, 14118.85881141196, 14119.294035298399, 10237.692869213935, 10288.537015834305, 10291.639792607222, 10292.897071029194, 10302.948485257675, 15415.768763468557, 15730.0, 16887.408940687263, 17230.0, 17336.826631733773, 6577.322782690383, 6592.0, 6677.298883617247, 6938.653067346713, 7110.680019399036, 792.2908996448147, 890.6348397157135, 896.789254525186, 956.4357029352576, 1010.6917390195914, 27675.86162069177, 28051.43897122087, 28203.077353755532, 28646.427071458453, 28844.711552884623, 938.8403971324891, 954.8233576788316, 983.7540614846289, 992.2805965674828, 998.83519219328, 14579.0, 15120.54638360851, 15195.164265965257, 15213.315400806769, 15251.92374038145, 370070.0, 374424.0, 375319.0, 375406.0, 375648.0, 43572.56427435685, 44288.77855610701, 44345.334819977725, 50469.0, 52958.47041529613, 1059.4543809937888, 1172.407933993345, 1199.6760874563993, 1207.8309036734863, 1210.5218438716481, 27641.723582763916, 29075.7092429073, 29835.0, 30159.0, 30181.0, 43130.353044704985, 43345.714871344106, 43398.132037359705, 43408.782956085015, 43533.78233108814, 377838.0, 387195.0, 387946.0, 585129.0, 589775.0, 38127.80936095302, 38548.42177367285, 38566.0, 38724.22551548897, 39423.21153576855, 41987.37018944657, 42187.0, 42197.578024220595, 42366.57633423626, 43237.0, 34997.30005399827, 35395.46906796349, 35415.64584354227, 35642.28715425625, 35661.465078023335, 36167.0, 36710.26579468449, 36764.816175918946, 36768.63231367652, 36908.630913691595, 35827.82086089553, 35831.64168358283, 35952.82023589865, 35997.64002359943, 36327.0, 31092.533611996292, 31571.0, 32580.090389153454, 33155.33689326248, 35403.0, 25330.746692532837, 25734.485310293316, 25837.612435813855, 25947.198609543015, 25985.350366240997], "value": 17845.628214270153, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.7421933549838, 360.7060245899593, 366.6132230496826, 370.24654827426184, 381.9446180303856, 12484.875151248485, 15677.52967410978, 15739.055656660594, 16189.35242590295, 17076.402325918596, 16457.423990160347, 16576.17119144044, 16611.750823737653, 16872.83127168728, 16982.915085424585, 4859.343988561552, 5062.443131255559, 5157.277981082651, 5363.436839131893, 5417.918731219035, 3378.1216883610314, 5391.406945236021, 5430.809921652743, 5440.891182176374, 5449.04641687705, 3498.6151523332414, 5135.58915286778, 5332.120200166968, 5377.865553361158, 5480.479354461319, 5427.0, 5478.342598888119, 5483.424240454755, 5487.945120548783, 5912.645241285537, 5255.922535880135, 5257.290265814105, 5258.7370631468275, 5262.0791361511965, 5278.841634750964, 12012.759744805142, 12208.877911220952, 18384.863405733737, 19035.428937131906, 19168.13743381551, 1888.8488920886296, 2074.968875466869, 2127.659574468093, 2271.4775601611555, 2339.1695947938406, 8807.823843523158, 8843.60203790831, 8966.730998070068, 9127.726168214964, 9145.954270228607, 1610.4443966831425, 1648.5796121988817, 1651.983480165195, 1762.938297159606, 1765.3821162593117, 67386.0, 69229.65385173092, 70091.29908700899, 70490.64754676246, 71497.0, 8971.372003959661, 9018.188363047226, 9110.908890911138, 9225.215856652125, 9554.952225238969, 12872.356382180853, 12888.226706397647, 12888.484460621657, 12925.612231633066, 12937.159084659466, 6415.807525774234, 6539.280679125292, 6544.181977252843, 6554.541182117206, 6794.898076528856, 6078.392160783975, 6117.541184411098, 6127.172831667757, 6214.875702486015, 6448.322926092693, 4009.51885773709, 4077.245709543744, 4157.605027522381, 4168.437260969791, 4299.591538803808, 1696.6267421167324, 1716.6738319719213, 1720.5698575356162, 1775.2810111904698, 1783.456045905985, 862.254150160107, 870.9608067636972, 877.0, 899.132337294514, 929.4934260827865, 15173.317200725995, 15629.0, 15828.60428489297, 16607.3357065716, 17012.48962531126, 825.9917400826035, 828.5194587139445, 837.8031162676766, 845.678642115992, 896.5920506169678, 8753.24935013, 9272.860907086399, 9291.442513449214, 9324.440533568008, 9450.43297402158, 368489.0, 371835.0, 372054.0, 372098.0, 372836.0, 73378.0, 75001.0, 76440.0, 77464.61267693738, 78646.6067669658, 851.3912552524974, 870.0081906626451, 870.4864130163107, 870.7083127152348, 874.0516539554654, 14188.432462701376, 14369.209693466959, 14514.201718905562, 14564.053336533092, 14591.635209119857, 36007.27985440329, 36014.8199259002, 36724.63275367212, 36923.44614830726, 38066.61933380631, 47638.523614764796, 48154.759226205046, 50938.74530627323, 51278.74360628173, 52070.0, 4678.60231880294, 5822.854428639318, 7316.670749816165, 7515.6242187891485, 7634.083909930844, 10699.358038517714, 11498.25261358009, 11539.192256542297, 11574.363410012531, 11812.055035596959, 10145.9492702536, 10208.438535880598, 10215.540300686338, 10458.26792124544, 10476.58093676275, 9932.900670993487, 10336.379817210991, 10342.172626189737, 10465.895341046493, 10474.423906685206, 10339.948300258451, 10346.793064138525, 10412.947935260276, 10555.313904596176, 10567.841482377617, 7260.96369518149, 7452.254774522505, 7543.622818858926, 7656.349210317186, 7701.037370328709, 9521.714348569554, 9861.852072218779, 10198.643047493302, 10249.0, 10279.0], "value": 7900.332191822318, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1225.9877401225986, 1340.9999999999998, 1389.465055953458, 1394.5676840179544, 1690.76329313896, 6891.414229790467, 7655.885161722578, 7939.761807145795, 7942.324902383304, 8139.145389734082, 7955.284024437799, 8040.8793868092025, 8044.637991290391, 8047.35621150308, 8054.91945080549, 2156.4608847788013, 2191.846570740041, 2192.6053310404122, 2194.846360754748, 2195.6816261642134, 2137.1451419432196, 2177.357679484548, 2192.9342119736434, 2194.9231776887814, 2200.449887528118, 2184.8907554622283, 2189.255653077961, 2200.526886719355, 2200.6698995150778, 2217.84475086744, 2112.4402033461147, 2113.8625989310644, 2117.1002324012234, 2121.257559854039, 2125.9255926042592, 2106.8630539015066, 2148.763636000039, 2152.35429371188, 2153.5262242306667, 2159.9568008639894, 7725.150233474314, 7895.210478952116, 7995.880061799077, 8047.0, 8048.597570121529, 4426.84506042287, 4619.076184763061, 4619.353290539327, 4623.491415944243, 4624.514425985257, 2835.801493895428, 2923.6199294091844, 2968.391479746647, 2974.881004759807, 2976.255936015996, 840.8360369727906, 850.7447765670274, 862.8231212601402, 865.1651156633878, 870.7257213977576, 10893.07408870247, 11011.229213955026, 11031.72420689481, 11047.889521104766, 11049.668509944715, 3788.0, 3979.2638361902564, 4002.219567184371, 4091.488563929509, 4111.76647005897, 8587.656493740305, 8617.48295102296, 8617.78455538604, 8619.051904290523, 8619.138086191331, 4513.50351461339, 4522.29904364824, 4522.728636281834, 4526.275795872644, 4529.728216307032, 3729.813509324523, 3839.8080095995088, 4108.36320370343, 4193.706440549132, 4216.47294088239, 3311.8012919224925, 3351.614564325134, 3427.246005878703, 3435.57055368079, 3455.3089382123676, 967.2455484721928, 978.9070038346346, 982.4841957971979, 989.4904124375952, 1000.8798944126752, 673.9224989126313, 743.8846978718308, 805.4844899264475, 827.4485339987524, 845.9534725590029, 5066.771995260222, 5106.668066575735, 5283.52448279649, 5319.281896943863, 5353.946460535422, 354.16593921314933, 359.740986489727, 359.87044663920966, 360.7078266604059, 375.76139151638904, 3383.8477268522975, 3463.1342164458883, 3468.289000754839, 3492.9126771830397, 3633.9091522711615, 9544.95227523858, 9950.45272510019, 9974.750631234132, 9986.850197247048, 10007.299489035844, 9881.061299176567, 9921.40471571708, 9921.702348929544, 9931.65239216624, 9934.552945117486, 7271.63641817907, 7389.81525461857, 7448.441366897396, 7459.254074592606, 7460.738874139379, 5076.36545431821, 5184.092783762751, 5301.6818990860675, 5329.733513324396, 5408.5673146149, 8886.955565222133, 9061.048589897966, 9062.456252624863, 9079.818403632022, 9149.77125571866, 9226.308026898143, 9255.35212535116, 9277.350585459222, 9293.070692930653, 9301.116393942564, 5787.061334452837, 5952.970235148797, 6272.40412160844, 6339.366063393623, 6341.460975817107, 7336.266373362834, 7441.330280274801, 7524.623768811428, 7704.075510938723, 7711.8843217352905, 6602.867942641216, 6647.767328143492, 6721.697523611351, 6794.422474089758, 6892.724291028303, 6150.630962142286, 6228.781992630236, 6256.749730010749, 6597.2742998271115, 6665.466762658879, 6282.371762823681, 6351.841203969938, 6353.5870168438905, 6357.332480089524, 6391.424771770563, 4278.122984788049, 4368.759718215529, 4391.385206071089, 4452.0205554777895, 4489.34904438861, 4355.89110272233, 4431.8448854289945, 4462.799174037111, 4507.5943165115295, 4546.318052292183], "value": 3969.666201490149, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.8560248279584, 297.1071928853794, 306.0710742895312, 307.22885557251294, 308.7591678490778, 4834.516548345164, 4865.245886887529, 4874.48817874123, 4880.9256066171865, 4899.191633380488, 4815.0, 4819.855404337866, 4841.491643377448, 4844.709317440956, 4844.781984810683, 3625.546806649169, 3722.8510859565586, 3740.3267411865854, 3806.181670940747, 3847.5960024197475, 3823.541175058997, 3834.9424758628643, 3836.693064554829, 3843.4619153318417, 3868.516435445569, 3792.3742582473997, 3796.8291426885858, 3797.2215695782297, 3797.468354430382, 3816.580176180632, 3591.8685614031497, 3707.369747142965, 3726.6646001859826, 3778.9433158502643, 3818.198178382543, 3393.33829903169, 3397.11674964511, 3398.1164897126678, 3398.1844357354057, 3402.302527981758, 4664.717202769266, 4727.7163370197895, 4728.810847566093, 4729.0, 4742.454617718972, 4194.790260486994, 4320.805563749639, 4341.891452713676, 4343.087951530182, 4350.8042138103865, 4991.376077990251, 5000.374953130859, 5001.974990125026, 5009.824656137018, 5014.047331007097, 3696.667299942991, 3697.020289623225, 3701.7223708221723, 3714.8699795507027, 3721.6836568891677, 5080.923786143211, 5259.316288882497, 5266.4733526647415, 5271.710055946922, 5290.074237008508, 3730.54508741591, 3736.4955730976512, 3741.7193710471824, 3767.547894252707, 3778.809674952381, 3764.698824094066, 3786.8106594670157, 3794.298054859805, 3830.636089571486, 3858.9228215436096, 4338.6312163466455, 4347.891302717458, 4360.629346505519, 4364.498082720528, 4383.364412160219, 4775.641826863, 4932.53140951609, 4949.455559888409, 4984.975075124674, 5001.5498605124985, 1308.4177540994167, 1336.4720935230723, 1336.5722968649939, 1337.3513845784787, 1344.7512210241136, 835.8006261015341, 857.2756021162108, 872.1583671756658, 877.5651809291726, 887.4763889305341, 4295.183915056129, 4329.718568293051, 4424.070945101565, 4428.911421771547, 4438.048697616114, 5198.506141916512, 5224.357693690805, 5225.268462415265, 5230.189320655304, 5246.7638956247065, 4433.179861725526, 4451.796360801424, 4455.9554404456185, 4456.532064133284, 4462.955370446319, 2621.84268943864, 2762.48893954615, 2792.0, 2792.6229958955687, 2797.4405118976288, 4898.579411970489, 4901.0, 4908.9263661045115, 4909.729964851967, 4911.877203069952, 5208.322918020633, 5277.683338999673, 5372.865678358073, 5380.7309634518115, 5405.972970135203, 4796.136695394863, 4824.469308376146, 4836.347093142451, 4851.320815085891, 4914.778834952435, 5167.431582525844, 5183.714895680774, 5192.324997750419, 5201.92197117036, 5204.609654276021, 4928.383952005999, 5067.923981140212, 5106.923396149135, 5127.512886275797, 5133.281340612242, 4871.953779412726, 4876.146674332049, 4876.487968763229, 4882.194437917846, 4883.291922671264, 3369.9663003370633, 3377.67912048355, 3381.9661803382637, 3394.6435624259097, 3401.2007178312583, 4472.635846066851, 4678.251479763221, 4678.368420263221, 4697.530246975275, 4710.528947105262, 4519.954800451954, 4520.547945205453, 4528.43394575678, 4529.139463501924, 4541.977290113528, 4488.483824360241, 4520.344550040291, 4528.43394575678, 4549.545045495424, 4572.268437050056, 4486.551344865487, 4487.6185524230805, 4501.639868810553, 4509.594136527729, 4537.617750680919, 4671.369365135663, 4761.309610106585, 5122.4910936008955, 5179.585633149414, 5192.870178245574, 5054.16606259963, 5059.443461219189, 5073.797048118034, 5084.01723327895, 5085.516875896784], "value": 3774.025154356329, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.805817963713, 594.8156071617797, 602.5169179627211, 679.9864002719946, 718.1705130574186, 11416.200865939387, 12161.756764864698, 12164.574239901605, 12182.390880455974, 12185.878141218585, 11564.826527602092, 11652.417379131031, 11685.240459370136, 11725.355105469196, 11732.0, 624.1199908129538, 630.6310808177221, 745.4818900863888, 752.5183882315323, 758.5600351795973, 773.0954782904016, 773.2576726342689, 773.5165521549031, 773.6402572803645, 774.9186335434782, 806.9798255043612, 809.3929552835374, 810.6109067647533, 810.9878351824727, 811.253646645085, 655.4101308822075, 665.9700313485905, 777.747232149548, 794.8370584030259, 805.2913436176157, 594.7829042399536, 595.4194660206308, 595.5682130455428, 595.7348979703991, 595.8569943213641, 11839.881601183964, 11862.406879655982, 11887.227330223594, 11897.167198296123, 11907.464164112636, 12772.680682982907, 13150.539731109366, 13483.460661573525, 13505.729885402237, 13557.661058473519, 11739.530418783239, 11775.941120294343, 11870.109741769402, 11914.582989595323, 12133.453994570265, 4087.5955933870837, 4106.342985122366, 4110.23960567293, 4170.979145104286, 4178.603032711888, 53030.46969530294, 55035.69785812864, 55104.448955510336, 63278.68360658213, 65592.0, 9934.701958941243, 10001.699949001542, 10118.747031324128, 10289.74275643115, 10428.217883658755, 18628.72056919147, 18628.906855465637, 18628.906855465637, 18635.90682046581, 18643.161057752433, 6338.904916426257, 6367.108604795332, 6439.259485159267, 6607.372299631527, 6772.051912732221, 3476.878309259164, 3509.0876372142916, 3523.894283171509, 3627.056965189017, 3695.6858667013066, 3051.0, 3231.563738895266, 3257.820819854931, 3265.053134590942, 3270.8037517749012, 551.1952549278019, 554.0166204986182, 559.1361346719328, 560.3863769172749, 564.7627996241588, 439.87903326585445, 520.4431258553311, 545.0135255188122, 576.3602401334515, 579.4205794205794, 7499.512531685423, 7872.685092596232, 7909.604519773989, 7915.683372665029, 7981.68073277074, 509.85214287856104, 553.8006317725616, 570.2700543304577, 580.4021857486796, 588.7880363069291, 3672.3756961316108, 3850.3839385698716, 3906.7655940643654, 3971.543272523639, 3976.940345894814, 102573.48713256535, 102906.0, 104035.0, 104068.0, 107011.0, 86421.56789216014, 87353.0, 87771.56114219388, 89253.0, 91203.54398228099, 72228.63885680643, 78484.60757696175, 78495.0, 79111.60444197858, 79211.20788792154, 7325.706971721072, 7442.1441534222095, 7488.887666685113, 7849.960750196213, 7882.881756773768, 45556.54443455523, 45627.54372456366, 45997.77001114973, 46341.53658463507, 46342.76828615835, 37953.0, 46550.30174547317, 51075.48924510707, 53725.462745372046, 55306.72346638241, 10798.190135739695, 10946.507407166855, 11505.827412588651, 11627.186096973131, 12155.331456769962, 12144.939275303566, 12495.562655307021, 12909.806352904527, 13381.53164639233, 13617.65955851072, 10835.566577337133, 11271.605493807678, 11509.424528773696, 11771.0, 11983.820242696542, 11439.0, 11878.584249551224, 12243.571474998333, 12253.816192756938, 12614.306213158365, 11158.944205278922, 11411.429428528374, 11501.309921404743, 11583.594574189863, 11641.359725214856, 9595.856062159213, 9697.315020292244, 9794.559244834141, 9988.153376287722, 10119.190464762949, 9098.860018691346, 10139.138173255356, 10184.388936663823, 10241.180705543688, 10307.226957978031], "value": 6471.51589913638, "unit": "score"}], "name": "dromaeo_css", "value": 6321.575656338911, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 115.0, 114.0, 114.0, 114.0, 113.0, 113.0, 114.0, 113.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 124.0, 122.0, 173.0, 127.0, 125.0, 131.0, 123.0, 155.0, 124.0], "value": 136.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 162.0, 161.0, 161.0, 163.0, 162.0, 161.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 111.0, 77.0, 76.0, 76.0, 76.0, 126.0, 76.0], "value": 84.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 115.0, 84.0, 85.0, 85.0, 105.0, 84.0, 85.0, 113.0], "value": 92.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 145.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 63.0, 64.0, 63.0, 64.0, 63.0, 63.0, 63.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 66.0, 67.0, 66.0, 66.0, 67.0, 66.0, 66.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 89.0, 86.0, 81.0, 82.0, 81.0, 82.0, 81.0, 82.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 144.0, 136.0, 133.0, 135.0, 135.0, 134.0, 134.0, 169.0, 142.0], "value": 140.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 173.0, 173.0, 178.0, 177.0, 174.0, 177.0, 181.0, 174.0, 172.0], "value": 175.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 68.0, 70.0, 75.0, 70.0, 70.0, 69.0, 68.0, 68.0], "value": 69.6, "unit": "score"}], "name": "kraken", "value": 1546.0, "alertThreshold": 2.0}]} 04:43:41 INFO - Return code: 0 04:43:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:43:41 INFO - # TBPL SUCCESS # 04:43:41 INFO - Running post-action listener: _resource_record_post_action 04:43:41 INFO - [mozharness: 2016-09-27 11:43:41.331042Z] Finished run-tests step (success) 04:43:41 INFO - Running post-run listener: _resource_record_post_run 04:43:41 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 0; Write bytes: 407461888; Read time: 0; Write time: 247212 04:43:41 INFO - TinderboxPrint: CPU usage
13.0% 04:43:41 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:43:41 INFO - TinderboxPrint: I/O write bytes / time
407,461,888 / 247,212 04:43:41 INFO - TinderboxPrint: CPU idle
8,348.0 (87.0%) 04:43:41 INFO - TinderboxPrint: CPU user
1,202.3 (12.5%) 04:43:41 INFO - TinderboxPrint: Swap in / out
0 / 0 04:43:41 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 115937280; Read time: 0; Write time: 88488 04:43:41 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 290590720; Read time: 0; Write time: 158696 04:43:41 INFO - Running post-run listener: _upload_blobber_files 04:43:41 INFO - Blob upload gear active. 04:43:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:43:41 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 04:43:41 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:43:41 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:43:42 INFO - (blobuploader) - INFO - Open directory for files ... 04:43:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:43:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:43:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:43 INFO - (blobuploader) - INFO - Done attempting. 04:43:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:43:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:43:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:44 INFO - (blobuploader) - INFO - Done attempting. 04:43:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:43:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:43:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:49 INFO - (blobuploader) - INFO - Done attempting. 04:43:49 INFO - (blobuploader) - INFO - Iteration through files over. 04:43:49 INFO - Return code: 0 04:43:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:43:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:43:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/75c089ef57e3b4bc55b83a3b2b34beb74f94c9944873513590841c124ea7eb26e852a8ada1464954aac76613482f81113bd640e6c79a696156ce1e67c0898439", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/141c9093c082396cf692de0d7616a642677e3389eda94152462dd39d9df78b61f7db3e00149692c29d3b1385b939af1fad8284fad5335b51ec78b83f0430f8e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6e970008a2eb4ca5b524e138cbda239c7d23a5cdd56c1b166e8b0acab08a7ed41b69d9c4faff33389ed207b5a8f570348f2be2f5ff4e6235b37a2f536d75707e"} 04:43:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:43:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:43:49 INFO - Contents: 04:43:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/75c089ef57e3b4bc55b83a3b2b34beb74f94c9944873513590841c124ea7eb26e852a8ada1464954aac76613482f81113bd640e6c79a696156ce1e67c0898439", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/141c9093c082396cf692de0d7616a642677e3389eda94152462dd39d9df78b61f7db3e00149692c29d3b1385b939af1fad8284fad5335b51ec78b83f0430f8e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6e970008a2eb4ca5b524e138cbda239c7d23a5cdd56c1b166e8b0acab08a7ed41b69d9c4faff33389ed207b5a8f570348f2be2f5ff4e6235b37a2f536d75707e"} 04:43:49 INFO - Running post-run listener: copy_logs_to_upload_dir 04:43:49 INFO - Copying logs to upload dir... 04:43:49 INFO - mkdir: /builds/slave/test/build/upload/logs 04:43:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.362039 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-09-27 04:43:48.761893) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 04:43:48.765655) ========= 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=41bf3e9aed84707956354da8000001c5-1474975308.293297-2130552337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/75c089ef57e3b4bc55b83a3b2b34beb74f94c9944873513590841c124ea7eb26e852a8ada1464954aac76613482f81113bd640e6c79a696156ce1e67c0898439", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/141c9093c082396cf692de0d7616a642677e3389eda94152462dd39d9df78b61f7db3e00149692c29d3b1385b939af1fad8284fad5335b51ec78b83f0430f8e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6e970008a2eb4ca5b524e138cbda239c7d23a5cdd56c1b166e8b0acab08a7ed41b69d9c4faff33389ed207b5a8f570348f2be2f5ff4e6235b37a2f536d75707e"} build_url:https://queue.taskcluster.net/v1/task/bIgegn4jQeGRfc8wTBh2Ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011284 build_url: 'https://queue.taskcluster.net/v1/task/bIgegn4jQeGRfc8wTBh2Ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/75c089ef57e3b4bc55b83a3b2b34beb74f94c9944873513590841c124ea7eb26e852a8ada1464954aac76613482f81113bd640e6c79a696156ce1e67c0898439", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/141c9093c082396cf692de0d7616a642677e3389eda94152462dd39d9df78b61f7db3e00149692c29d3b1385b939af1fad8284fad5335b51ec78b83f0430f8e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6e970008a2eb4ca5b524e138cbda239c7d23a5cdd56c1b166e8b0acab08a7ed41b69d9c4faff33389ed207b5a8f570348f2be2f5ff4e6235b37a2f536d75707e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 04:43:48.795053) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 04:43:48.795890) ========= 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=41bf3e9aed84707956354da8000001c5-1474975308.293297-2130552337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004427 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 04:43:48.881380) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 04:43:48.882095) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 04:43:48.882809) ========= ========= Total master_lag: 0.19 =========