builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-061 starttime: 1474632609.26 results: success (0) buildid: 20160923041700 builduid: e244da3a890a41b2998aa2ba10341702 revision: 2e46d0c12db68401969a817832329187da8add06 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 05:10:09.263963) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 05:10:09.264369) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 05:10:09.265048) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 05:10:09.292942) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 05:10:09.293242) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1474631992.119591-886655371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-23 05:10:09-- 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% 226M=0s 2016-09-23 05:10:10 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126099 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 05:10:09.433589) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 05:10:09.433929) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1474631992.119591-886655371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015870 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 05:10:09.487005) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-23 05:10:09.487837) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2e46d0c12db68401969a817832329187da8add06 --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 2e46d0c12db68401969a817832329187da8add06 --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=516f8d7ca085b4d087ab0a71000001a4-1474631992.119591-886655371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-23 05:10:10,202 truncating revision to first 12 chars 2016-09-23 05:10:10,202 Setting DEBUG logging. 2016-09-23 05:10:10,202 attempt 1/10 2016-09-23 05:10:10,202 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2e46d0c12db6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-23 05:10:10,885 unpacking tar archive at: fx-team-2e46d0c12db6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.024165 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-23 05:10:10.527239) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 05:10:10.527572) ========= script_repo_revision: 2e46d0c12db68401969a817832329187da8add06 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 05:10:10.528065) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 05:10:10.528384) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 05:10:10.539112) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-09-23 05:10:10.539422) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1474631992.119591-886655371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:10:11 INFO - MultiFileLogger online at 20160923 05:10:11 in /builds/slave/test 05:10:11 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 05:10:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:10:11 INFO - {'append_to_log': False, 05:10:11 INFO - 'base_work_dir': '/builds/slave/test', 05:10:11 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:10:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:10:11 INFO - 'branch': 'Fx-Team-Non-PGO', 05:10:11 INFO - 'buildbot_json_path': 'buildprops.json', 05:10:11 INFO - 'config_files': ('talos/linux_config.py',), 05:10:11 INFO - 'default_actions': ('clobber', 05:10:11 INFO - 'read-buildbot-config', 05:10:11 INFO - 'download-and-extract', 05:10:11 INFO - 'populate-webroot', 05:10:11 INFO - 'create-virtualenv', 05:10:11 INFO - 'install', 05:10:11 INFO - 'run-tests'), 05:10:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:10:11 INFO - 'download_minidump_stackwalk': True, 05:10:11 INFO - 'download_symbols': 'ondemand', 05:10:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:10:11 INFO - 'tooltool.py': '/tools/tooltool.py', 05:10:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:10:11 INFO - '/tools/misc-python/virtualenv.py')}, 05:10:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:10:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:10:11 INFO - 'installer_path': 'installer.exe', 05:10:11 INFO - 'log_level': 'info', 05:10:11 INFO - 'log_name': 'talos', 05:10:11 INFO - 'log_to_console': True, 05:10:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:10:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:10:11 INFO - 'opt_config_files': (), 05:10:11 INFO - 'pip_index': False, 05:10:11 INFO - 'sps_profile': False, 05:10:11 INFO - 'sps_profile_interval': 0, 05:10:11 INFO - 'suite': 'dromaeojs', 05:10:11 INFO - 'system_bits': '32', 05:10:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:10:11 INFO - 'title': 'talos-linux64-ix-061', 05:10:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:10:11 INFO - 'use_talos_json': True, 05:10:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:10:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:10:11 INFO - 'work_dir': 'build'} 05:10:11 INFO - [mozharness: 2016-09-23 12:10:11.345323Z] Running clobber step. 05:10:11 INFO - Running pre-action listener: _resource_record_pre_action 05:10:11 INFO - Running main action method: clobber 05:10:11 INFO - rmtree: /builds/slave/test/build 05:10:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:10:11 INFO - Running post-action listener: _resource_record_post_action 05:10:11 INFO - [mozharness: 2016-09-23 12:10:11.799918Z] Finished clobber step (success) 05:10:11 INFO - [mozharness: 2016-09-23 12:10:11.800017Z] Running read-buildbot-config step. 05:10:11 INFO - Running pre-action listener: _resource_record_pre_action 05:10:11 INFO - Running main action method: read_buildbot_config 05:10:11 INFO - Using buildbot properties: 05:10:11 INFO - { 05:10:11 INFO - "project": "", 05:10:11 INFO - "product": "firefox", 05:10:11 INFO - "script_repo_revision": "production", 05:10:11 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:10:11 INFO - "repository": "", 05:10:11 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:10:11 INFO - "buildid": "20160923041700", 05:10:11 INFO - "pgo_build": "False", 05:10:11 INFO - "basedir": "/builds/slave/test", 05:10:11 INFO - "buildnumber": 3348, 05:10:11 INFO - "slavename": "talos-linux64-ix-061", 05:10:11 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:10:11 INFO - "platform": "ubuntu64_hw", 05:10:11 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:10:11 INFO - "branch": "fx-team", 05:10:11 INFO - "repo_path": "integration/fx-team", 05:10:11 INFO - "revision": "2e46d0c12db68401969a817832329187da8add06", 05:10:11 INFO - "stage_platform": "linux64", 05:10:11 INFO - "builduid": "e244da3a890a41b2998aa2ba10341702", 05:10:11 INFO - "slavebuilddir": "test" 05:10:11 INFO - } 05:10:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/Zbvo8lYaSHmrdXd3kH0TFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 05:10:11 INFO - Running post-action listener: _resource_record_post_action 05:10:11 INFO - [mozharness: 2016-09-23 12:10:11.802448Z] Finished read-buildbot-config step (success) 05:10:11 INFO - [mozharness: 2016-09-23 12:10:11.802537Z] Running download-and-extract step. 05:10:11 INFO - Running pre-action listener: _resource_record_pre_action 05:10:11 INFO - Running main action method: download_and_extract 05:10:11 INFO - mkdir: /builds/slave/test/build/tests 05:10:11 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')]} 05:10:11 INFO - trying https://queue.taskcluster.net/v1/task/Zbvo8lYaSHmrdXd3kH0TFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:10:11 INFO - Downloading https://queue.taskcluster.net/v1/task/Zbvo8lYaSHmrdXd3kH0TFg/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 05:10:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zbvo8lYaSHmrdXd3kH0TFg/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 05:10:12 INFO - Downloaded 1361 bytes. 05:10:12 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:10:12 INFO - Using the following test package requirements: 05:10:12 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:10:12 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:10:12 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:10:12 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:12 INFO - u'jsshell-linux-x86_64.zip'], 05:10:12 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:10:12 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:10:12 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:10:12 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:10:12 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:10:12 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:10:12 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:10:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zbvo8lYaSHmrdXd3kH0TFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:10:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zbvo8lYaSHmrdXd3kH0TFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:10:12 INFO - Fetch https://queue.taskcluster.net/v1/task/Zbvo8lYaSHmrdXd3kH0TFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:10:13 INFO - Expected file size: 20377253 05:10:18 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 05:10:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zbvo8lYaSHmrdXd3kH0TFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:10:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zbvo8lYaSHmrdXd3kH0TFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:10:18 INFO - Fetch https://queue.taskcluster.net/v1/task/Zbvo8lYaSHmrdXd3kH0TFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:10:19 INFO - Expected file size: 20377253 05:10:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zbvo8lYaSHmrdXd3kH0TFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 05:10:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zbvo8lYaSHmrdXd3kH0TFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:10:24 INFO - Fetch https://queue.taskcluster.net/v1/task/Zbvo8lYaSHmrdXd3kH0TFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 05:10:24 INFO - Expected file size: 14414059 05:10:25 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')]} 05:10:25 INFO - trying https://queue.taskcluster.net/v1/task/Zbvo8lYaSHmrdXd3kH0TFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:10:25 INFO - Downloading https://queue.taskcluster.net/v1/task/Zbvo8lYaSHmrdXd3kH0TFg/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 05:10:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zbvo8lYaSHmrdXd3kH0TFg/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 05:10:27 INFO - Downloaded 55725445 bytes. 05:10:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zbvo8lYaSHmrdXd3kH0TFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:10:27 INFO - mkdir: /builds/slave/test/properties 05:10:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:10:27 INFO - Writing to file /builds/slave/test/properties/build_url 05:10:27 INFO - Contents: 05:10:27 INFO - build_url:https://queue.taskcluster.net/v1/task/Zbvo8lYaSHmrdXd3kH0TFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:10:28 INFO - Running post-action listener: _resource_record_post_action 05:10:28 INFO - Running post-action listener: set_extra_try_arguments 05:10:28 INFO - [mozharness: 2016-09-23 12:10:28.492631Z] Finished download-and-extract step (success) 05:10:28 INFO - [mozharness: 2016-09-23 12:10:28.492859Z] Running populate-webroot step. 05:10:28 INFO - Running pre-action listener: _resource_record_pre_action 05:10:28 INFO - Running main action method: populate_webroot 05:10:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:10:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:10:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:10:28 INFO - '--tppagecycles', 05:10:28 INFO - '7'], 05:10:28 INFO - 'tests': ['tsvgm']}}, 05:10:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:10:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:10:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:10:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:10:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:10:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:10:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:28 INFO - 'talos_options': ['--disable-e10s'], 05:10:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:10:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:10:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:28 INFO - 'talos_options': ['--disable-e10s'], 05:10:28 INFO - 'tests': ['damp', 'tps']}, 05:10:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:28 INFO - 'tests': ['damp', 'tps']}, 05:10:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:10:28 INFO - 'tests': ['dromaeo_dom']}, 05:10:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:10:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:10:28 INFO - 'tests': ['basic_compositor_video']}, 05:10:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:10:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:10:28 INFO - 'tests': ['a11yr', 05:10:28 INFO - 'ts_paint', 05:10:28 INFO - 'tpaint', 05:10:28 INFO - 'sessionrestore', 05:10:28 INFO - 'sessionrestore_no_auto_restore', 05:10:28 INFO - 'tabpaint']}, 05:10:28 INFO - 'other-e10s': {'tests': ['a11yr', 05:10:28 INFO - 'ts_paint', 05:10:28 INFO - 'tpaint', 05:10:28 INFO - 'sessionrestore', 05:10:28 INFO - 'sessionrestore_no_auto_restore', 05:10:28 INFO - 'tabpaint']}, 05:10:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:10:28 INFO - 'ts_paint', 05:10:28 INFO - 'tpaint', 05:10:28 INFO - 'sessionrestore', 05:10:28 INFO - 'sessionrestore_no_auto_restore', 05:10:28 INFO - 'tabpaint']}, 05:10:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:10:28 INFO - 'ts_paint', 05:10:28 INFO - 'tpaint', 05:10:28 INFO - 'sessionrestore', 05:10:28 INFO - 'sessionrestore_no_auto_restore', 05:10:28 INFO - 'tabpaint']}, 05:10:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:10:28 INFO - 'tests': ['a11yr', 05:10:28 INFO - 'ts_paint', 05:10:28 INFO - 'tpaint', 05:10:28 INFO - 'sessionrestore', 05:10:28 INFO - 'sessionrestore_no_auto_restore', 05:10:28 INFO - 'tabpaint']}, 05:10:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:10:28 INFO - 'tests': ['a11yr', 05:10:28 INFO - 'ts_paint', 05:10:28 INFO - 'tpaint', 05:10:28 INFO - 'sessionrestore', 05:10:28 INFO - 'sessionrestore_no_auto_restore', 05:10:28 INFO - 'tabpaint']}, 05:10:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:10:28 INFO - 'tests': ['tsvgx', 05:10:28 INFO - 'tsvgr_opacity', 05:10:28 INFO - 'tart', 05:10:28 INFO - 'tscrollx', 05:10:28 INFO - 'cart']}, 05:10:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:10:28 INFO - 'tsvgr_opacity', 05:10:28 INFO - 'tart', 05:10:28 INFO - 'tscrollx', 05:10:28 INFO - 'cart']}, 05:10:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:28 INFO - 'talos_options': ['--disable-e10s'], 05:10:28 INFO - 'tests': ['tp5o']}, 05:10:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:28 INFO - 'tests': ['tp5o']}, 05:10:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:28 INFO - 'talos_options': ['--disable-e10s', 05:10:28 INFO - '--xperf_path', 05:10:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:10:28 INFO - 'tests': ['tp5n']}, 05:10:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:28 INFO - 'talos_options': ['--xperf_path', 05:10:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:10:28 INFO - 'tests': ['tp5n']}}, 05:10:28 INFO - 'talos.zip': {'path': '', 05:10:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:10:28 INFO - Running post-action listener: _resource_record_post_action 05:10:28 INFO - [mozharness: 2016-09-23 12:10:28.512382Z] Finished populate-webroot step (success) 05:10:28 INFO - [mozharness: 2016-09-23 12:10:28.512470Z] Running create-virtualenv step. 05:10:28 INFO - Running pre-action listener: _resource_record_pre_action 05:10:28 INFO - Running main action method: create_virtualenv 05:10:28 INFO - Creating virtualenv /builds/slave/test/build/venv 05:10:28 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 05:10:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:10:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:10:28 INFO - Using real prefix '/usr' 05:10:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:10:29 INFO - Installing distribute.............................................................................................................................................................................................done. 05:10:31 INFO - Installing pip.................done. 05:10:31 INFO - Return code: 0 05:10:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:10:31 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')]} 05:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:31 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')]} 05:10:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x7fbea8412f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdcf60>, '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 0x1fddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fde1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1474631992.119591-886655371', '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 05:10:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 05:10:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.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 05:10:31 INFO - Using env: {'DISPLAY': ':0', 05:10:31 INFO - 'HOME': '/home/cltbld', 05:10:31 INFO - 'LANG': 'en_US.UTF-8', 05:10:31 INFO - 'LANGUAGE': 'en_US:en', 05:10:31 INFO - 'LOGNAME': 'cltbld', 05:10:31 INFO - 'MAIL': '/var/mail/cltbld', 05:10:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:31 INFO - 'MOZ_NO_REMOTE': '1', 05:10:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:31 INFO - 'NO_EM_RESTART': '1', 05:10:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:31 INFO - 'PWD': '/builds/slave/test', 05:10:31 INFO - 'SHELL': '/bin/bash', 05:10:31 INFO - 'SHLVL': '1', 05:10:31 INFO - 'TERM': 'linux', 05:10:31 INFO - 'TMOUT': '86400', 05:10:31 INFO - 'USER': 'cltbld', 05:10:31 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474631992.119591-886655371', 05:10:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:31 INFO - '_': '/tools/buildbot/bin/python'} 05:10:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:31 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 05:10:31 INFO - Cleaning up... 05:10:31 INFO - Return code: 0 05:10:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:10:31 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')]} 05:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:31 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')]} 05:10:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x7fbea8412f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdcf60>, '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 0x1fddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fde1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1474631992.119591-886655371', '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 05:10:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 05:10:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.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 05:10:31 INFO - Using env: {'DISPLAY': ':0', 05:10:31 INFO - 'HOME': '/home/cltbld', 05:10:31 INFO - 'LANG': 'en_US.UTF-8', 05:10:31 INFO - 'LANGUAGE': 'en_US:en', 05:10:31 INFO - 'LOGNAME': 'cltbld', 05:10:31 INFO - 'MAIL': '/var/mail/cltbld', 05:10:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:31 INFO - 'MOZ_NO_REMOTE': '1', 05:10:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:31 INFO - 'NO_EM_RESTART': '1', 05:10:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:31 INFO - 'PWD': '/builds/slave/test', 05:10:31 INFO - 'SHELL': '/bin/bash', 05:10:31 INFO - 'SHLVL': '1', 05:10:31 INFO - 'TERM': 'linux', 05:10:31 INFO - 'TMOUT': '86400', 05:10:31 INFO - 'USER': 'cltbld', 05:10:31 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474631992.119591-886655371', 05:10:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:31 INFO - '_': '/tools/buildbot/bin/python'} 05:10:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:31 INFO - Downloading/unpacking psutil>=3.1.1 05:10:31 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 05:10:31 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 05:10:31 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 05:10:31 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 05:10:31 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 05:10:31 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 05:10:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:10:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:10:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:10:33 INFO - Installing collected packages: psutil 05:10:33 INFO - Running setup.py install for psutil 05:10:33 INFO - building 'psutil._psutil_linux' extension 05:10:33 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 05:10:33 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 05:10:33 INFO - building 'psutil._psutil_posix' extension 05:10:33 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 05:10:33 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 05:10:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:10:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:10:34 INFO - Successfully installed psutil 05:10:34 INFO - Cleaning up... 05:10:34 INFO - Return code: 0 05:10:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:10:34 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')]} 05:10:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:34 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')]} 05:10:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:34 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 0x7fbea8412f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdcf60>, '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 0x1fddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fde1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1474631992.119591-886655371', '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 05:10:34 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 05:10:34 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 05:10:34 INFO - Using env: {'DISPLAY': ':0', 05:10:34 INFO - 'HOME': '/home/cltbld', 05:10:34 INFO - 'LANG': 'en_US.UTF-8', 05:10:34 INFO - 'LANGUAGE': 'en_US:en', 05:10:34 INFO - 'LOGNAME': 'cltbld', 05:10:34 INFO - 'MAIL': '/var/mail/cltbld', 05:10:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:34 INFO - 'MOZ_NO_REMOTE': '1', 05:10:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:34 INFO - 'NO_EM_RESTART': '1', 05:10:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:34 INFO - 'PWD': '/builds/slave/test', 05:10:34 INFO - 'SHELL': '/bin/bash', 05:10:34 INFO - 'SHLVL': '1', 05:10:34 INFO - 'TERM': 'linux', 05:10:34 INFO - 'TMOUT': '86400', 05:10:34 INFO - 'USER': 'cltbld', 05:10:34 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474631992.119591-886655371', 05:10:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:34 INFO - '_': '/tools/buildbot/bin/python'} 05:10:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:10:34 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 05:10:34 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 05:10:34 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 05:10:34 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 05:10:34 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 05:10:34 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 05:10:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:10:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:10:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:10:36 INFO - Installing collected packages: mozsystemmonitor 05:10:36 INFO - Running setup.py install for mozsystemmonitor 05:10:36 INFO - Successfully installed mozsystemmonitor 05:10:36 INFO - Cleaning up... 05:10:36 INFO - Return code: 0 05:10:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:10:36 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')]} 05:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:36 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')]} 05:10:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:36 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 0x7fbea8412f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdcf60>, '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 0x1fddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fde1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1474631992.119591-886655371', '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 05:10:36 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 05:10:36 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 05:10:36 INFO - Using env: {'DISPLAY': ':0', 05:10:36 INFO - 'HOME': '/home/cltbld', 05:10:36 INFO - 'LANG': 'en_US.UTF-8', 05:10:36 INFO - 'LANGUAGE': 'en_US:en', 05:10:36 INFO - 'LOGNAME': 'cltbld', 05:10:36 INFO - 'MAIL': '/var/mail/cltbld', 05:10:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:36 INFO - 'MOZ_NO_REMOTE': '1', 05:10:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:36 INFO - 'NO_EM_RESTART': '1', 05:10:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:36 INFO - 'PWD': '/builds/slave/test', 05:10:36 INFO - 'SHELL': '/bin/bash', 05:10:36 INFO - 'SHLVL': '1', 05:10:36 INFO - 'TERM': 'linux', 05:10:36 INFO - 'TMOUT': '86400', 05:10:36 INFO - 'USER': 'cltbld', 05:10:36 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474631992.119591-886655371', 05:10:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:36 INFO - '_': '/tools/buildbot/bin/python'} 05:10:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:36 INFO - Downloading/unpacking jsonschema==2.5.1 05:10:36 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 05:10:36 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 05:10:36 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 05:10:36 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 05:10:36 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 05:10:36 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 05:10:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:10:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:10:38 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 05:10:38 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 05:10:38 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 05:10:38 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 05:10:38 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 05:10:38 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 05:10:38 INFO - Downloading functools32-3.2.3-2.tar.gz 05:10:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:10:38 INFO - warning: no files found matching '*.txt' 05:10:38 INFO - no previously-included directories found matching 'build' 05:10:38 INFO - no previously-included directories found matching 'dist' 05:10:38 INFO - no previously-included directories found matching '.git*' 05:10:38 INFO - Installing collected packages: jsonschema, functools32 05:10:38 INFO - Running setup.py install for functools32 05:10:38 INFO - warning: no files found matching '*.txt' 05:10:38 INFO - no previously-included directories found matching 'build' 05:10:38 INFO - no previously-included directories found matching 'dist' 05:10:38 INFO - no previously-included directories found matching '.git*' 05:10:38 INFO - Successfully installed jsonschema functools32 05:10:38 INFO - Cleaning up... 05:10:39 INFO - Return code: 0 05:10:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:10:39 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')]} 05:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:39 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')]} 05:10:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:39 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 0x7fbea8412f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdcf60>, '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 0x1fddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fde1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1474631992.119591-886655371', '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 05:10:39 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 05:10:39 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 05:10:39 INFO - Using env: {'DISPLAY': ':0', 05:10:39 INFO - 'HOME': '/home/cltbld', 05:10:39 INFO - 'LANG': 'en_US.UTF-8', 05:10:39 INFO - 'LANGUAGE': 'en_US:en', 05:10:39 INFO - 'LOGNAME': 'cltbld', 05:10:39 INFO - 'MAIL': '/var/mail/cltbld', 05:10:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:39 INFO - 'MOZ_NO_REMOTE': '1', 05:10:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:39 INFO - 'NO_EM_RESTART': '1', 05:10:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:39 INFO - 'PWD': '/builds/slave/test', 05:10:39 INFO - 'SHELL': '/bin/bash', 05:10:39 INFO - 'SHLVL': '1', 05:10:39 INFO - 'TERM': 'linux', 05:10:39 INFO - 'TMOUT': '86400', 05:10:39 INFO - 'USER': 'cltbld', 05:10:39 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474631992.119591-886655371', 05:10:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:39 INFO - '_': '/tools/buildbot/bin/python'} 05:10:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:10:39 INFO - Cleaning up... 05:10:39 INFO - Return code: 0 05:10:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:10:39 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')]} 05:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:39 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')]} 05:10:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:39 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 0x7fbea8412f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdcf60>, '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 0x1fddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fde1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1474631992.119591-886655371', '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 05:10:39 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 05:10:39 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 05:10:39 INFO - Using env: {'DISPLAY': ':0', 05:10:39 INFO - 'HOME': '/home/cltbld', 05:10:39 INFO - 'LANG': 'en_US.UTF-8', 05:10:39 INFO - 'LANGUAGE': 'en_US:en', 05:10:39 INFO - 'LOGNAME': 'cltbld', 05:10:39 INFO - 'MAIL': '/var/mail/cltbld', 05:10:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:39 INFO - 'MOZ_NO_REMOTE': '1', 05:10:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:39 INFO - 'NO_EM_RESTART': '1', 05:10:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:39 INFO - 'PWD': '/builds/slave/test', 05:10:39 INFO - 'SHELL': '/bin/bash', 05:10:39 INFO - 'SHLVL': '1', 05:10:39 INFO - 'TERM': 'linux', 05:10:39 INFO - 'TMOUT': '86400', 05:10:39 INFO - 'USER': 'cltbld', 05:10:39 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474631992.119591-886655371', 05:10:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:39 INFO - '_': '/tools/buildbot/bin/python'} 05:10:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:39 INFO - Downloading/unpacking blobuploader==1.2.4 05:10:39 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 05:10:39 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 05:10:39 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 05:10:39 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 05:10:39 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 05:10:39 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 05:10:41 INFO - Downloading blobuploader-1.2.4.tar.gz 05:10:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:10:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:10:41 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 05:10:41 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 05:10:41 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 05:10:41 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 05:10:41 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 05:10:41 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 05:10:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:10:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:10:41 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 05:10:41 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 05:10:41 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 05:10:41 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 05:10:41 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 05:10:41 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 05:10:42 INFO - Downloading docopt-0.6.1.tar.gz 05:10:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:10:42 INFO - Installing collected packages: blobuploader, requests, docopt 05:10:42 INFO - Running setup.py install for blobuploader 05:10:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:10:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:10:42 INFO - Running setup.py install for requests 05:10:42 INFO - Running setup.py install for docopt 05:10:42 INFO - Successfully installed blobuploader requests docopt 05:10:42 INFO - Cleaning up... 05:10:42 INFO - Return code: 0 05:10:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:10:42 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')]} 05:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:42 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')]} 05:10:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:42 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 0x7fbea8412f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdcf60>, '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 0x1fddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fde1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1474631992.119591-886655371', '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 05:10:42 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 05:10:42 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 05:10:42 INFO - Using env: {'DISPLAY': ':0', 05:10:42 INFO - 'HOME': '/home/cltbld', 05:10:42 INFO - 'LANG': 'en_US.UTF-8', 05:10:42 INFO - 'LANGUAGE': 'en_US:en', 05:10:42 INFO - 'LOGNAME': 'cltbld', 05:10:42 INFO - 'MAIL': '/var/mail/cltbld', 05:10:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:42 INFO - 'MOZ_NO_REMOTE': '1', 05:10:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:42 INFO - 'NO_EM_RESTART': '1', 05:10:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:42 INFO - 'PWD': '/builds/slave/test', 05:10:42 INFO - 'SHELL': '/bin/bash', 05:10:42 INFO - 'SHLVL': '1', 05:10:42 INFO - 'TERM': 'linux', 05:10:42 INFO - 'TMOUT': '86400', 05:10:42 INFO - 'USER': 'cltbld', 05:10:42 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474631992.119591-886655371', 05:10:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:42 INFO - '_': '/tools/buildbot/bin/python'} 05:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:10:42 INFO - Running setup.py (path:/tmp/pip-VynK40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:10:43 INFO - Running setup.py (path:/tmp/pip-48eCn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:10:43 INFO - Running setup.py (path:/tmp/pip-INFxpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:10:43 INFO - Running setup.py (path:/tmp/pip-aA7ffn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:10:43 INFO - Running setup.py (path:/tmp/pip-tLbm8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:10:43 INFO - Running setup.py (path:/tmp/pip-GjB76s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:10:43 INFO - Running setup.py (path:/tmp/pip-kasT2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:10:43 INFO - Running setup.py (path:/tmp/pip-tPpHrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:10:43 INFO - Running setup.py (path:/tmp/pip-L28WM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:10:43 INFO - Running setup.py (path:/tmp/pip-Bs6r1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:10:43 INFO - Running setup.py (path:/tmp/pip-VFps3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:10:43 INFO - Running setup.py (path:/tmp/pip-RB36K_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:10:43 INFO - Running setup.py (path:/tmp/pip-eMfqwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:10:43 INFO - Running setup.py (path:/tmp/pip-Tg4Lvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:43 INFO - Running setup.py (path:/tmp/pip-HPU1p7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:10:44 INFO - Running setup.py (path:/tmp/pip-3XH0z8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:10:44 INFO - Running setup.py (path:/tmp/pip-zycFen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:10:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:10:44 INFO - Running setup.py install for manifestparser 05:10:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:10:44 INFO - Running setup.py install for mozcrash 05:10:44 INFO - Running setup.py install for mozdebug 05:10:44 INFO - Running setup.py install for mozdevice 05:10:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:10:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:10:44 INFO - Running setup.py install for mozfile 05:10:44 INFO - Running setup.py install for mozhttpd 05:10:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:10:44 INFO - Running setup.py install for mozinfo 05:10:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:10:44 INFO - Running setup.py install for mozInstall 05:10:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:10:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:10:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:10:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:10:45 INFO - Running setup.py install for mozleak 05:10:45 INFO - Running setup.py install for mozlog 05:10:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:10:45 INFO - Running setup.py install for moznetwork 05:10:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:10:45 INFO - Running setup.py install for mozprocess 05:10:45 INFO - Running setup.py install for mozprofile 05:10:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:10:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:10:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:10:45 INFO - Running setup.py install for mozrunner 05:10:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:10:45 INFO - Running setup.py install for mozscreenshot 05:10:45 INFO - Running setup.py install for moztest 05:10:45 INFO - Running setup.py install for mozversion 05:10:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:10:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:10:45 INFO - Cleaning up... 05:10:46 INFO - Return code: 0 05:10:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:10:46 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')]} 05:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:46 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')]} 05:10:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:46 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 0x7fbea8412f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdcf60>, '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 0x1fddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fde1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1474631992.119591-886655371', '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 05:10:46 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 05:10:46 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 05:10:46 INFO - Using env: {'DISPLAY': ':0', 05:10:46 INFO - 'HOME': '/home/cltbld', 05:10:46 INFO - 'LANG': 'en_US.UTF-8', 05:10:46 INFO - 'LANGUAGE': 'en_US:en', 05:10:46 INFO - 'LOGNAME': 'cltbld', 05:10:46 INFO - 'MAIL': '/var/mail/cltbld', 05:10:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:46 INFO - 'MOZ_NO_REMOTE': '1', 05:10:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:46 INFO - 'NO_EM_RESTART': '1', 05:10:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:46 INFO - 'PWD': '/builds/slave/test', 05:10:46 INFO - 'SHELL': '/bin/bash', 05:10:46 INFO - 'SHLVL': '1', 05:10:46 INFO - 'TERM': 'linux', 05:10:46 INFO - 'TMOUT': '86400', 05:10:46 INFO - 'USER': 'cltbld', 05:10:46 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474631992.119591-886655371', 05:10:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:46 INFO - '_': '/tools/buildbot/bin/python'} 05:10:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:10:46 INFO - Running setup.py (path:/tmp/pip-GNkgaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:10:46 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)) 05:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:10:46 INFO - Running setup.py (path:/tmp/pip-BXuCqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:10:46 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)) 05:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:10:46 INFO - Running setup.py (path:/tmp/pip-B2jZ95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:10:46 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)) 05:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:10:46 INFO - Running setup.py (path:/tmp/pip-73jsY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:10:46 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)) 05:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:10:46 INFO - Running setup.py (path:/tmp/pip-kp6AK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:10:46 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)) 05:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:10:46 INFO - Running setup.py (path:/tmp/pip-BR73B3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:10:46 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)) 05:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:10:46 INFO - Running setup.py (path:/tmp/pip-vRq_dk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:10:46 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)) 05:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:10:46 INFO - Running setup.py (path:/tmp/pip-K3QwFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:10:46 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)) 05:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:10:46 INFO - Running setup.py (path:/tmp/pip-NWkW0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:10:46 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)) 05:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:10:46 INFO - Running setup.py (path:/tmp/pip-oLjamd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:10:46 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)) 05:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:10:46 INFO - Running setup.py (path:/tmp/pip-Sk45ue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:10:47 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)) 05:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:10:47 INFO - Running setup.py (path:/tmp/pip-8vP16t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:10:47 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)) 05:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:10:47 INFO - Running setup.py (path:/tmp/pip-8pWWiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:10:47 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)) 05:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:10:47 INFO - Running setup.py (path:/tmp/pip-1VU4mG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:10:47 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)) 05:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:47 INFO - Running setup.py (path:/tmp/pip-hDHTye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:47 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)) 05:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:10:47 INFO - Running setup.py (path:/tmp/pip-6JhJMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:10:47 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)) 05:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:10:47 INFO - Running setup.py (path:/tmp/pip-JBe26s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:10:47 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)) 05:10:47 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)) 05:10:47 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)) 05:10:47 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)) 05:10:47 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)) 05:10:47 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)) 05:10:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:10:47 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 05:10:47 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 05:10:47 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 05:10:47 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 05:10:47 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 05:10:47 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 05:10:49 INFO - Downloading blessings-1.6.tar.gz 05:10:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:10:49 INFO - Installing collected packages: blessings 05:10:49 INFO - Running setup.py install for blessings 05:10:49 INFO - Successfully installed blessings 05:10:49 INFO - Cleaning up... 05:10:49 INFO - Return code: 0 05:10:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:10:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:10:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:10:49 INFO - Reading from file tmpfile_stdout 05:10:49 INFO - Current package versions: 05:10:49 INFO - argparse == 1.2.1 05:10:49 INFO - blessings == 1.6 05:10:49 INFO - blobuploader == 1.2.4 05:10:49 INFO - docopt == 0.6.1 05:10:49 INFO - functools32 == 3.2.3-2 05:10:49 INFO - jsonschema == 2.5.1 05:10:49 INFO - manifestparser == 1.1 05:10:49 INFO - mozInstall == 1.12 05:10:49 INFO - mozcrash == 0.17 05:10:49 INFO - mozdebug == 0.1 05:10:49 INFO - mozdevice == 0.48 05:10:49 INFO - mozfile == 1.2 05:10:49 INFO - mozhttpd == 0.7 05:10:49 INFO - mozinfo == 0.9 05:10:49 INFO - mozleak == 0.1 05:10:49 INFO - mozlog == 3.4 05:10:49 INFO - moznetwork == 0.27 05:10:49 INFO - mozprocess == 0.23 05:10:49 INFO - mozprofile == 0.28 05:10:49 INFO - mozrunner == 6.12 05:10:49 INFO - mozscreenshot == 0.1 05:10:49 INFO - mozsystemmonitor == 0.3 05:10:49 INFO - moztest == 0.7 05:10:49 INFO - mozversion == 1.4 05:10:49 INFO - psutil == 3.1.1 05:10:49 INFO - requests == 1.2.3 05:10:49 INFO - wsgiref == 0.1.2 05:10:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:10:49 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')]} 05:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:49 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')]} 05:10:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:49 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 0x7fbea8412f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdcf60>, '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 0x1fddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fde1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1474631992.119591-886655371', '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 05:10:49 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 05:10:49 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 05:10:49 INFO - Using env: {'DISPLAY': ':0', 05:10:49 INFO - 'HOME': '/home/cltbld', 05:10:49 INFO - 'LANG': 'en_US.UTF-8', 05:10:49 INFO - 'LANGUAGE': 'en_US:en', 05:10:49 INFO - 'LOGNAME': 'cltbld', 05:10:49 INFO - 'MAIL': '/var/mail/cltbld', 05:10:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:49 INFO - 'MOZ_NO_REMOTE': '1', 05:10:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:49 INFO - 'NO_EM_RESTART': '1', 05:10:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:49 INFO - 'PWD': '/builds/slave/test', 05:10:49 INFO - 'SHELL': '/bin/bash', 05:10:49 INFO - 'SHLVL': '1', 05:10:49 INFO - 'TERM': 'linux', 05:10:49 INFO - 'TMOUT': '86400', 05:10:49 INFO - 'USER': 'cltbld', 05:10:49 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474631992.119591-886655371', 05:10:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:49 INFO - '_': '/tools/buildbot/bin/python'} 05:10:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:50 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)) 05:10:50 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)) 05:10:50 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)) 05:10:50 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)) 05:10:50 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)) 05:10:50 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)) 05:10:50 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)) 05:10:50 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)) 05:10:50 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)) 05:10:50 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)) 05:10:50 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)) 05:10:50 INFO - Cleaning up... 05:10:50 INFO - Return code: 0 05:10:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:10:50 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')]} 05:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:50 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')]} 05:10:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:50 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 0x7fbea8412f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdcf60>, '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 0x1fddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fde1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1474631992.119591-886655371', '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 05:10:50 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 05:10:50 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 05:10:50 INFO - Using env: {'DISPLAY': ':0', 05:10:50 INFO - 'HOME': '/home/cltbld', 05:10:50 INFO - 'LANG': 'en_US.UTF-8', 05:10:50 INFO - 'LANGUAGE': 'en_US:en', 05:10:50 INFO - 'LOGNAME': 'cltbld', 05:10:50 INFO - 'MAIL': '/var/mail/cltbld', 05:10:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:50 INFO - 'MOZ_NO_REMOTE': '1', 05:10:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:50 INFO - 'NO_EM_RESTART': '1', 05:10:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:50 INFO - 'PWD': '/builds/slave/test', 05:10:50 INFO - 'SHELL': '/bin/bash', 05:10:50 INFO - 'SHLVL': '1', 05:10:50 INFO - 'TERM': 'linux', 05:10:50 INFO - 'TMOUT': '86400', 05:10:50 INFO - 'USER': 'cltbld', 05:10:50 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474631992.119591-886655371', 05:10:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:50 INFO - '_': '/tools/buildbot/bin/python'} 05:10:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:10:50 INFO - Cleaning up... 05:10:50 INFO - Return code: 0 05:10:50 INFO - Running post-action listener: _resource_record_post_action 05:10:50 INFO - Running post-action listener: _start_resource_monitoring 05:10:50 INFO - Starting resource monitoring. 05:10:50 INFO - [mozharness: 2016-09-23 12:10:50.345045Z] Finished create-virtualenv step (success) 05:10:50 INFO - [mozharness: 2016-09-23 12:10:50.345550Z] Running install step. 05:10:50 INFO - Running pre-action listener: _resource_record_pre_action 05:10:50 INFO - Running main action method: install 05:10:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:10:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:10:50 INFO - Reading from file tmpfile_stdout 05:10:50 INFO - Detecting whether we're running mozinstall >=1.0... 05:10:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:10:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:10:50 INFO - Reading from file tmpfile_stdout 05:10:50 INFO - Output received: 05:10:50 INFO - Usage: mozinstall [options] installer 05:10:50 INFO - Options: 05:10:50 INFO - -h, --help show this help message and exit 05:10:50 INFO - -d DEST, --destination=DEST 05:10:50 INFO - Directory to install application into. [default: 05:10:50 INFO - "/builds/slave/test"] 05:10:50 INFO - --app=APP Application being installed. [default: firefox] 05:10:50 INFO - mkdir: /builds/slave/test/build/application 05:10:50 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'] 05:10:50 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 05:11:06 INFO - Reading from file tmpfile_stdout 05:11:06 INFO - Output received: 05:11:06 INFO - /builds/slave/test/build/application/firefox/firefox 05:11:06 INFO - Running post-action listener: _resource_record_post_action 05:11:06 INFO - [mozharness: 2016-09-23 12:11:06.732653Z] Finished install step (success) 05:11:06 INFO - [mozharness: 2016-09-23 12:11:06.732896Z] Running run-tests step. 05:11:06 INFO - Running pre-action listener: _resource_record_pre_action 05:11:06 INFO - Running main action method: run_tests 05:11:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:11:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:11:06 INFO - Python 2.7.3 05:11:06 INFO - Return code: 0 05:11:06 INFO - grabbing minidump binary from tooltool 05:11:06 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')]} 05:11:06 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 0x1fdcf60>, '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 0x1fddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fde1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:11:06 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 05:11:06 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 05:11:06 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 05:11:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:11:06 INFO - Return code: 0 05:11:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:11:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:11:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:11:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:11:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:11:06 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/Zbvo8lYaSHmrdXd3kH0TFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 05:11:06 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/Zbvo8lYaSHmrdXd3kH0TFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 05:11:06 INFO - Using env: {'DISPLAY': ':0', 05:11:06 INFO - 'HOME': '/home/cltbld', 05:11:06 INFO - 'LANG': 'en_US.UTF-8', 05:11:06 INFO - 'LANGUAGE': 'en_US:en', 05:11:06 INFO - 'LOGNAME': 'cltbld', 05:11:06 INFO - 'MAIL': '/var/mail/cltbld', 05:11:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:11:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:06 INFO - 'MOZ_NO_REMOTE': '1', 05:11:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:11:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:06 INFO - 'NO_EM_RESTART': '1', 05:11:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:06 INFO - 'PWD': '/builds/slave/test', 05:11:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:11:06 INFO - 'SHELL': '/bin/bash', 05:11:06 INFO - 'SHLVL': '1', 05:11:06 INFO - 'TERM': 'linux', 05:11:06 INFO - 'TMOUT': '86400', 05:11:06 INFO - 'USER': 'cltbld', 05:11:06 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474631992.119591-886655371', 05:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:06 INFO - '_': '/tools/buildbot/bin/python'} 05:11:06 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/Zbvo8lYaSHmrdXd3kH0TFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 05:11:07 INFO - mozversion application_buildid: 20160923041700 05:11:07 INFO - mozversion application_changeset: 2e46d0c12db68401969a817832329187da8add06 05:11:07 INFO - mozversion application_display_name: Nightly 05:11:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:11:07 INFO - mozversion application_name: Firefox 05:11:07 INFO - mozversion application_remotingname: firefox 05:11:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:11:07 INFO - mozversion application_vendor: Mozilla 05:11:07 INFO - mozversion application_version: 52.0a1 05:11:07 INFO - mozversion platform_buildid: 20160923041700 05:11:07 INFO - mozversion platform_changeset: 2e46d0c12db68401969a817832329187da8add06 05:11:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:11:07 INFO - mozversion platform_version: 52.0a1 05:11:07 INFO - using testdate: 1474632667 05:11:07 INFO - actual date: 1474632667 05:11:07 INFO - starting webserver on 'localhost:50770' 05:11:07 INFO - SUITE-START | Running 2 tests 05:11:07 INFO - TEST-START | dromaeo_css 05:11:07 INFO - operating with platform_type : linux_ 05:11:07 INFO - Initialising browser for dromaeo_css test... 05:11:07 INFO - TEST-INFO | started process 17925 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmOAVWf/profile http://localhost:50770/getInfo.html) 05:11:12 INFO - PROCESS | 17925 | __metrics Screen width/height:1600/1200 05:11:12 INFO - PROCESS | 17925 | colorDepth:24 05:11:12 INFO - PROCESS | 17925 | Browser inner width/height: 1024/697 05:11:12 INFO - PROCESS | 17925 | __metrics 05:11:12 INFO - PROCESS | 17925 | 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" 05:11:12 INFO - PROCESS | 17925 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:11:13 INFO - PROCESS | 17925 | console.error: PushService: 05:11:13 INFO - PROCESS | 17925 | stateChangeProcessEnqueue: Error transitioning state 05:11:13 INFO - PROCESS | 17925 | UnknownError 05:11:13 INFO - TEST-INFO | 17925: exit 0 05:11:13 INFO - Browser initialized. 05:11:13 INFO - Running cycle 1/1 for dromaeo_css test... 05:11:13 INFO - TEST-INFO | started process 18009 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmOAVWf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:11:25 INFO - PROCESS | 18009 | RSS: Main: 175640576 05:11:25 INFO - PROCESS | 18009 | 05:12:17 INFO - PROCESS | 18009 | 1474632737099 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] 05:14:30 INFO - PROCESS | 18009 | Cycle 1(1): loaded http://localhost:50770/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50770/tests/dromaeo/cssquery-ext.html) 05:14:31 INFO - PROCESS | 18009 | RSS: Main: 269180928 05:14:31 INFO - PROCESS | 18009 | 05:17:34 INFO - PROCESS | 18009 | Cycle 1(1): loaded http://localhost:50770/tests/dromaeo/cssquery-ext.html (next: http://localhost:50770/tests/dromaeo/cssquery-jquery.html) 05:17:35 INFO - PROCESS | 18009 | RSS: Main: 271020032 05:17:35 INFO - PROCESS | 18009 | 05:20:37 INFO - PROCESS | 18009 | Cycle 1(1): loaded http://localhost:50770/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50770/tests/dromaeo/cssquery-mootools.html) 05:20:38 INFO - PROCESS | 18009 | RSS: Main: 215150592 05:20:38 INFO - PROCESS | 18009 | 05:23:40 INFO - PROCESS | 18009 | Cycle 1(1): loaded http://localhost:50770/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50770/tests/dromaeo/cssquery-prototype.html) 05:23:40 INFO - PROCESS | 18009 | RSS: Main: 216068096 05:23:40 INFO - PROCESS | 18009 | 05:26:44 INFO - PROCESS | 18009 | Cycle 1(1): loaded http://localhost:50770/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50770/tests/dromaeo/cssquery-yui.html) 05:26:44 INFO - PROCESS | 18009 | RSS: Main: 217309184 05:26:44 INFO - PROCESS | 18009 | 05:29:47 INFO - PROCESS | 18009 | Cycle 1(1): loaded http://localhost:50770/tests/dromaeo/cssquery-yui.html (next: http://localhost:50770/tests/dromaeo/cssquery-dojo.html) 05:29:48 INFO - PROCESS | 18009 | RSS: Main: 310370304 05:29:48 INFO - PROCESS | 18009 | 05:29:48 INFO - PROCESS | 18009 | __start_tp_report 05:29:48 INFO - PROCESS | 18009 | _x_x_mozilla_page_load 05:29:48 INFO - PROCESS | 18009 | _x_x_mozilla_page_load_details 05:29:48 INFO - PROCESS | 18009 | |i|pagename|runs| 05:29:48 INFO - PROCESS | 18009 | |0;dojo.html;2606.296299999;2638.419547699508;2667.733226677332;2674.318048897531;2681.7184195659456;4594.908101837961;4697.765111744417;4711.740854253015;4811.518848115191;4852.85441436757;4683.882902927428;4694.7183169009795;4720.173969555322;4732.432108147019;4743.928841067387;4276.593723596261;4318.546552611978;4400.801963911632;4460.063386688783;4466;4315.697901146921;4351.673624478161;4362.32383980482;4452.643788496929;4476.12715520472;4365.869023929287;4400.537943515933;4472.3515090311885;4507.391502147218;4520.457545094577;4455.064436468346;4473.194824931511;4513.074819661962;4521.163584736834;4533.070720502289;4279.529251782302;4310.676699247538;4314.072474418015;4365.432493775789;4414.271645178574;4622.260438329851;4650.674452788307;4673.345731597579;4679.883002924954;4688.5077066907825;4975.651704380694;4987.700737955734;5026.89946201074;5038.370203724535;5088.821891233789;4955.876103097451;5093.668911520739;5094.133997220481;5104.3619547556555;5161.793528258865;4655.650826188049;4715.316279139505;4766.547178018082;4780.665353425227;4791.496892826272;5171.095058364771;5197.298364720715;5215.16557350822;5223.738813059332;5292.41783403833;4889.731064791471;5002.249662550574;5005.924911126336;5006.249062640561;5008.273800298936;5025.698458092526;5081.0092032054135;5110.1568241239775;5124.5131712487255;5218.7912483500995;5079.492050794965;5091.389033315952;5099.974500127476;5101.7704203310195;5158.045761534128;4783.856484305406;5062.797488100435;5064.974675126601;5072.568831649277;5124.641275110781;4225.133847561243;4274.252005899018;4278.978605107017;4284.635805956528;4299.355096735515;3776.5090538229856;3810.0855794609647;3839.6544311012144;3856.8071596420627;3879.4374815652136;4427.136708341907;4435.977820110943;4443.33349997503;4479.686421950432;4481.798319075584;5138.974305128525;5150.175971844562;5150.510701483353;5154.613403994716;5163.328767260232;4256.723312984646;4347.239233134189;4384.167008268419;4405.559444055633;4425.889352766207;4630.58324750774;4664.790084446208;4665.533446655308;4720.103180395714;4724.503927087675;4867.70793752376;4872.951270487391;4873.074115917964;4876.561109500091;4935.235038568884;4927.1131196384995;4973.030259099585;4984.576311013604;5023.146065169003;5164.690118592896;4764.047190561971;4767.523247675344;4768.880777980578;4809.0862736080035;4831.323614693875;4961.255811628284;4966.180580204225;4966.354373931365;4968.975155124202;4996.475370086088;5009.474005229544;5026.371703537058;5042.243663450365;5049.116404629249;5080.314157588678;4919.975400122977;4966.155753521838;4967.975160124176;5016.197408414636;5024.070546948826;4946.901061978812;4960.032793605213;4964;4964.205727083649;5028.874278143076;4686.8125274988615;4732.313814496947;4888.413390393175;4901.264810278487;4908.828191013297;4913.361263035782;4932.457429682804;4954.777035033504;4980.103581355391;5035.899282014266;4769.642276829182;4821.228603423436;4828.8792780180775;4829.7585120744525;4838.879028024327 05:29:48 INFO - PROCESS | 18009 | |1;ext.html;528.5428104689445;558.6759679385957;580.6312991250558;584.5498965796337;584.8947189505892;27792.86103569482;30796.692033079664;30825.07524774255;30850.074497765047;30856.228594285127;30216.848915755447;38498.422523662164;39278.80360598193;39363.40954885672;43401.34897976533;7585.848283034336;7730.8453830923345;7743.4966727162555;7752.534847909115;7756.418268629847;7601.315881570657;7684.885691574718;7691.038620172479;7695.538267703928;7695.538267703928;7718.151003389623;7752.844943101135;7753.379729621645;7754.534727916315;7758.883616745753;7683.846323073535;7719.38244940409;7736.071671399412;7738.806529836743;7739.419543534257;7664.233576642347;7670.386369090459;7707.113681926538;7723.845523089507;7730.536167829948;37455.25089498222;37730.62269377299;37772.43341349882;37798.81100594479;37839;3077.830719310437;3084.228942764309;3101.72084512395;3211.74306055515;3568.964310356889;27513.44973100547;27816.443671126668;28010.57984130219;28219.153425397064;28968.710312896812;3355.7315414767004;3391.173833571945;3430.485427185917;3500.8949731508096;3526.2947410518;233562;234004;234631.99999999828;234954;235847;51232.74383628058;51348;51405;51447.7427612867;51466.22800657993;31424.528632070538;32214.677853221638;32279;34385.140371490415;34448.65551344505;13825.861741382658;14079.859201407855;14098.718025639635;14107.929460352632;14143.858561414254;10415.479226038668;10628.521716522775;10678.73303167427;10693.465326733633;10714.732131696614;17819.910900445673;17874;18016.9099154506;18032.819671803376;18172.727409088875;6562.704678289393;6689.531732778756;6760.492963027694;6785.694643741043;6883.690233939485;761.2958013837178;826.1614461321764;880.3749337969984;920.8572671235969;995.7908839143861;26268.8686556566;27736.306592335353;28120.43759124806;28298.292542686188;28308;749.3630414147931;911.9179273865251;923.1184219070772;936.2556767369957;996.4917891875195;13254;14541.491047813275;14661.706765864623;14733.55799326022;14782.556523304318;363675;388841;393534;395881;579783;49195;49731.502684972686;49812.75093624509;49838.252426213636;49903.75048124736;1070.5931745936493;1075.736444571085;1144.4849817582121;1177.776222517719;1182.6688527212393;27708;31160.220994474414;31182.22044448816;31540.36919261648;31632.209194770316;46117;46861.29708054314;46882.296765547864;46887.062258755315;46889.296660550805;349568;350799;351160;353444;353453;24139.15512957038;25207.87396063008;30968.69031309658;31639.841800790848;34195.82902085573;37076.44385334168;37611;41149.588504114574;41401.792991036054;41624.50252984831;35417.468737969466;35438.11404714903;35512.11219719424;35999.46000809938;36027;35625.643743562236;35753.82123089368;35820.28359432745;36023;36032.639673603975;34305.65694343125;34866.302673946884;35044.82477587596;35690.821545892104;38110.428343575426;30167.245818853826;32702.509462357608;32762.180945476553;32793.50809737904;33060;24396.51206975886;24774.628380573944;24932.626010609492;25126.246212613652;25326.620100698874 05:29:48 INFO - PROCESS | 18009 | |2;jquery.html;345.2611411579222;370.36297568182715;377.0705211653274;379.2528718424703;387.778965989386;12470.251784892902;15466.304016319264;15527.378904843821;16534.7519787203;17664.205110770014;16441.177941102927;17311.74032389512;17334.826651733478;17377.73933391;17503.124843757825;5058.190689489682;5071.036503064415;5083.79664813407;5097.827499675077;5098.082345177866;3711.4247291669835;3905.6875449963936;5060.620453465986;5150.871228219287;5878.617889837147;6130.754769809202;6236.251649802008;6244.87510249797;6263.404976527246;6263.812085637415;5064.392272927235;5311.787528498855;5330.173823057432;5413.621046526745;6240.157578726882;5243.501867322599;5246.449122842123;5246.501582349671;5263.973680131575;5264.447233040552;11538.365389903553;11786.233894796811;12179.695507612292;12283.447244874002;13440.731185376335;1842.6406850664125;1869.2709843161178;1872.8354629817838;1922.0677971183964;1930.2182616040527;8518.616662250151;8862.158094980967;8996.280297576179;9377.29670274732;9499.24006079512;1772.7340898865145;1774.5652315182863;1778.5731424458038;1779.24382137591;1785.4199033855002;68891;69370.30629693689;70228.00197611666;70822.64588677076;72406.63796680982;9539.952300238454;9638.759031024281;9866.785962819424;9930.404175749478;10091.646792362379;13291.800622990662;13308.600741977756;13316.933415332862;13321.733565328639;13354.198748075147;6233.750649974041;6611.471082313404;6749.730010799513;7035.8241043973285;7036.050133232051;6385.425311721968;6424.421802037839;6464.321246269168;6595.85634668725;6604.834879127964;4056.8985775355854;4091.243120022805;4136.607022332873;4204.495460544754;4214.789260536961;1787.9463616091539;1793.4798908316702;1803.1435068342432;1808.2586139682667;1815.0652414006797;714.3249629100554;831.094107422912;853.4239388412797;876.8860048193822;963.1235575626287;15924.363025478851;16527.33890644385;16798.664026719398;17321.30714771395;17489.562760930825;811.3792948394483;819.5983967855827;842.3555979675554;845.691322667222;918.7014220378404;6836.555623884432;9390.201832844148;9609.279304052085;9666.323357365058;9667.564959576835;345974;350863;354832;356029;356127;54904.72547637236;58440;68429.31570684329;69584;75360.62319688367;806.1978331560135;830.8587540118074;835.5571547080058;841.1840514700853;887.3699673231948;14723;15529.76705349398;16014.67970640604;16335.183240837672;16452.095134767704;29281.707182927898;38129.42805857859;38619.420708689955;39448.605513944494;39927.600723992386;51653.741731291106;52402.47597524129;52408;52778.472215277354;53301;7248.456365772483;7731.613419329124;7743.4966727162555;7773.650185741542;8010;11002.229843910849;11799.76400472003;11957.701057473632;12142.028637709138;12218.20581662189;9893.208543316374;10030.29787914839;10202.285839991426;10273.486325683836;10511.579536818748;10132.34139780912;10235.283530152818;10304.330218535772;10454.68635940923;10555;10372.58509659605;10378.740531486774;10540.156787456832;10613.20400969915;10879.1840611956;6764.323567643196;7228.457865660202;7269.600171990592;7561.546307221364;8080.151584083822;9979;10084.344517606332;10237.129843963347;10658.680239592824;10686.946565267435 05:29:48 INFO - PROCESS | 18009 | |3;mootools.html;1363.6999860030792;1402.5722154742805;1467.7250262093758;1667.049781624473;1677.4883660483547;7782.377409807216;8289.378296627747;8300.086990431048;8303.750887473378;8305.709300174494;6709.899351509731;6959.130108736408;7654.961725191366;7857.135715071352;7884.960575197116;2050.1082029317295;2056.5784014277037;2067.266120527214;2076.0761461149796;2081.7189679393314;2073.1085633177727;2117.978820211801;2118.5233322502468;2148.967765483519;2160.8487405881597;1846.150770645498;1913.2347061175572;2113.6723807809735;2199.2632468123197;2206.7020952171492;2165.4911095892453;2170.696102545645;2174.1086154676505;2175.249538909082;2177.0421014753456;2138.636431806581;2138.9251376201914;2141.957160856774;2143.239150101707;2145.8927053647253;8129.105798362176;8141.674333026672;8180;8208.138145494697;8210.794730131734;4559.680822342404;4575.816967321303;4596.1267359201975;4617.215073437524;4627.676062675614;2832.1503548935443;3080.1067690369764;3086.861091250899;3087.6757940416383;3093.9845300773577;884.7168905950099;930.432436213909;933.3186773655269;945.9905400945971;962.1052421248237;11062;11123.888761112446;11169.162312826571;11204.719882002933;11212.999999999918;4031.133306339151;4202.957970420318;4290.849820256276;4376.124775045004;4411.691181617321;9408.858867116998;9423.05769423066;9433.716988490356;9438.197753190918;9438.811223775487;4533.32000199966;4554.362389265505;4557.863264102082;4559.703619264737;4560.817567297271;4068.8372465101656;4082.6529744971417;4085.2850751118435;4085.346344584852;4087.529934057562;3647.9635203648154;3738.7009039277336;3849.730518863653;3868.323043467382;3972.801359931992;1180.3979970215253;1212.1999480342931;1220.530095913062;1224.5469176404788;1235.5057976809169;645.686841881687;693.6947742993067;760.7261385901071;764.8661484240235;764.9732259370895;4903.607711383081;5008.474110218447;5015.072211640858;5022.773975171126;5140.023395554833;810.8175660476346;821.9917800821916;848.9151084891462;876.7194497760655;885.6723012485421;3175.3173067790076;3393.5079413484905;3433.1588760753275;3458.75788694794;3478.2695633916655;9417.529123543796;9706.563204655808;9800.36297640651;9884.456354900405;9892.604295828087;9703.854442183372;9732.2214222862;9836;9852.704418867446;9869.851952220723;6952.721891124298;7362.558246505227;7404;7480;7489.251074892576;5043.142665746758;5209.895802084013;5241.371035475768;5333.333333333333;5377.516023557899;8718.08460111679;8990.955045224731;9097;9171.908280917372;9216.677416290398;9108.316876234176;9223.30825188127;9284.907150928404;9311.394759340621;9360.859587106062;6736.360045795642;6847.1783385994;6855.725770969106;6857.348551887562;6861.725530978904;7571.962140189264;7587.58268295249;7604.467687261838;7664.34853037498;7690.384769218561;6942.375186233263;6949.30506949301;6955.234924158237;6993.895091573732;7014.508984371045;6747.359000894907;6756.763513277012;6782.118324617768;6789.762358317633;6824.7952561423235;5858.150568167677;5952.226210592596;5960.791372301948;5963.761449541969;5965.492933100735;4258.233517966796;4449.599536041772;4473.105378924293;4504.9099018020115;4648.465426475998;4362.563743625612;4363.541828108003;4540.160070386989;4548.135854187693;4549.45406551216 05:29:48 INFO - PROCESS | 18009 | |4;prototype.html;289.743576934413;291.3401146403396;299.08181881623426;300.1610498656256;300.5761875755184;4854.907645779702;4909.803607855691;4935.851924442263;4940.678855874366;4950.826721064764;4851.684640498374;4852.854414367565;4884.658073934817;4900.730459824708;4909.386326709161;3860.6718428933573;3878.6703130233964;3884.261990221863;3890.8249128789203;3893.669038131762;3747.812609369534;3806.015351160273;3882.7476214046137;3885.7279990400684;3890.2414029264305;3787.696984241254;3788.905277368074;3808.447775072613;3820.2741479119018;3827.349350610389;3780.8487660493684;3784.6215378462207;3788.9621103788886;3790.2040571480024;3802.619738026175;3141;3240.2061494933655;3370.7808992415416;3378.2905589826164;3381.357542067024;4598.137754209551;4667.509911459282;4699.368353721927;4713.198756211418;4717.9292310615365;4311.482622085338;4313.0726893718;4327.567243275679;4346.717463364871;4349.260625693608;4737.857864264078;4803.351547541072;5045.6215783816;5048.072118171452;5110.233464980245;3638.1450359165574;3649.8830678206577;3660.652238037382;3679.1170119171475;3708.554973403182;5239.633225674204;5278.604104692164;5288.867778305573;5294.338207724035;5296.470352964711;3593.2633810068874;3705.333040052816;3730.1420673245307;3736.4021756518828;3744.1762812181278;3785.73499855013;3799.145192331703;3807.2956503047026;3809.5238095238096;3814.8855534334016;4283.700140990163;4286.39990401344;4286.507051689034;4292.785360731951;4306.784660766949;5072.213806859869;5076.44159142494;5110.71891045996;5114.360704911886;5127.666701664454;1289.2264641215195;1311.0691409099456;1311.9081664283408;1313.1267706974945;1313.8160657507956;824.2458150791958;829.369679043919;849.5327569836566;852.071242345846;853.8227519824422;3957.465742124834;4009.9373665978537;4032.117036319046;4040.7373520721058;4042.6765858731233;4603.401557797465;4605.217113090783;4614.792334344963;4618.85223371134;4637.124982510865;4013.3712418366017;4023.255697695877;4038.1519880825354;4046.838126474967;4053.777042262645;2293.9655905161435;2487.863167525767;2490.340059884132;2492.0405643827257;2497.7627125423055;4452.12837719669;4454.844080457168;4722.693024953367;4861.6596838220985;4870.586000190024;5222.477752224747;5234.895302093937;5251.737413129405;5258.2638430619745;5373.892522149535;4973.676711013773;4975;4996.275540046673;4998.500149984972;5000.67495612784;5070.5943524517215;5228.843134705965;5265.815696450759;5269;5304.257403963526;5117.744112794271;5123.282740416419;5124.333836601218;5160.174372100446;5179.378474583074;4950.306957025947;4968.130577148912;4968.428630707371;4973.35346404965;4989.650724449254;3613.313470440608;3691.6123807000954;3724.385476396364;3736.7757934524016;3752.1182522106737;5276.920846187233;5277.340332458442;5281.788728450819;5325.786968521215;5328.8934221314585;5142.537171654569;5146.433892271922;5152.5877929766275;5155.407128180307;5162.5095615916425;4882.951170488392;5117.769700363567;5148.176291793295;5161.509656582619;5184.688918664892;5039.748012599429;5049.596032317332;5052.823151189691;5064.240363945438;5072.28987941681;5175.95549757851;5193.298904647824;5204.869878253074;5208.5312321891215;5220;4741.407324084489;4932.4081110267;4963.468630998144;4967.875803104951;4976.552110310089 05:29:48 INFO - PROCESS | 18009 | |5;yui.html;649.4252586460982;699.9580025198488;731.3138910055317;748.5433885329948;753.8040109571509;12404.503819847207;13363.465461381546;13365.599032029055;13379.665508362285;13400.530981415652;12801.679958001032;12812.679683007906;12815.743685126292;12844.293563853984;12866.806997895015;617.2038070888549;633.0188208277152;635.0347471842796;752.3755283115029;781.0510230070463;631.1321932343028;752.4995877741295;769.4575324396316;770.4645271536284;776.4603600497657;807.4630370803409;818.8976377952756;819.3527113580265;819.4386845011186;819.5082950229875;815.4332738746574;817.4032955942166;817.5421763812225;817.5707753429467;817.8936738224053;474.0116856354505;480.4162942025456;578.7800635758427;599.6522017230039;600.3546187848037;12212.694682632917;12824.87175128246;12839.614811555668;12879.935600321938;12882.098253122285;12464.563740269046;12678.80981785274;12857.4214160363;13119.540816071392;13549.661258468617;11142.220044596881;11441.599544015919;11520.193586448951;11573.942130289295;12163.878361216362;4080.775557344345;4100.0569868930015;4158.83552605268;4289.52815190332;4291.549387314319;52806.471935280926;55497.167542486895;55838;64254.03618945766;64331;10152.187824973984;10172.389656620626;10550.736231594117;10764.192685548458;11048.834267485994;18978.240870365305;18998.620027599372;19006.23975040983;19204.231830726894;19359.516012099528;7048.859022819617;7102.893456598155;7192.604406757679;7197.820054498679;7432.145303290083;3732.4774531565604;3885.3977633466857;3894.571597124314;3897.434871943609;3916.236333914859;2922.064939219472;3029.8485075746125;3043.9847800760854;3044.9238769030953;3048.603681521388;516.839779668304;522.4592546714133;523;530.6842428754885;541.0909671751417;480.62991496547465;589.9970500147472;591.3554225893711;619.4641634985705;647.7409036385484;8047.579778594074;8163.959180204061;8332.541710205876;8429.157084291523;8511.063782983867;483.43196743825865;493.49416847730646;555.5722093987607;592.2034863109197;605.1860247966478;3908.804559772057;4108.116754897652;4263.317869140985;4293;4303.935440968388;96032.51983740176;97839.02160978441;98287.50856245673;98991.50504247432;99205.50397248112;85174.57412712897;89714.8513267605;90621.54689226512;91171;92303;72351;72525;74469.62765186248;74684.25315746773;74770.25229747742;7458.403327733877;7953.5227886327;7964.681412743425;7990.8002299940645;8191.303739181998;40525.39211911883;41031.17937641171;41391.37912931369;41487.377689335284;42841.357379638706;55436.445635543125;58831.11753323618;61362.54549817957;63866;64291.357086430406;11266.211365204357;11270.830937536108;11304.321740695585;11950.282983021047;12301.753964920472;13003.674908126994;13393.866061339262;13567.52513662017;13956.651083722989;14410.495632652806;12131.090168237593;12271.509139634672;12347.62957111288;12625.87374126247;12640.431180596712;10699.411532365795;11683;11824.46789894474;12449.502019919102;12869.356532173166;11512.82730759056;12412;12739.490420383081;12741.17182383142;13432.664183395493;9947.651832185838;10003.34978226413;10551.366917984946;11188.444510400499;11337.433128343715;9800.558974846006;10126.645567405105;10168.237382196217;10170.440625765357;10267.178625710074 05:29:48 INFO - PROCESS | 18009 | __end_tp_report 05:29:48 INFO - PROCESS | 18009 | __start_cc_report 05:29:48 INFO - PROCESS | 18009 | _x_x_mozilla_cycle_collect,886 05:29:48 INFO - PROCESS | 18009 | __end_cc_report 05:29:48 INFO - PROCESS | 18009 | __startTimestamp1474633788213__endTimestamp 05:29:48 INFO - PROCESS | 18009 | 05:29:48 INFO - PROCESS | 18009 | ------- Summary: start ------- 05:29:48 INFO - PROCESS | 18009 | Number of tests: 6 05:29:48 INFO - PROCESS | 18009 | 05:29:48 INFO - PROCESS | 18009 | [#0] dojo.html Cycles:165 Average:4701.00 Median:4821.23 stddev:482.69 (10.0%) stddev-sans-first:455.34 05:29:48 INFO - PROCESS | 18009 | Values: 2606.3 2638.4 2667.7 2674.3 2681.7 4594.9 4697.8 4711.7 4811.5 4852.9 4683.9 4694.7 4720.2 4732.4 4743.9 4276.6 4318.5 4400.8 4460.1 4466.0 4315.7 4351.7 4362.3 4452.6 4476.1 4365.9 4400.5 4472.4 4507.4 4520.5 4455.1 4473.2 4513.1 4521.2 4533.1 4279.5 4310.7 4314.1 4365.4 4414.3 4622.3 4650.7 4673.3 4679.9 4688.5 4975.7 4987.7 5026.9 5038.4 5088.8 4955.9 5093.7 5094.1 5104.4 5161.8 4655.7 4715.3 4766.5 4780.7 4791.5 5171.1 5197.3 5215.2 5223.7 5292.4 4889.7 5002.2 5005.9 5006.2 5008.3 5025.7 5081.0 5110.2 5124.5 5218.8 5079.5 5091.4 5100.0 5101.8 5158.0 4783.9 5062.8 5065.0 5072.6 5124.6 4225.1 4274.3 4279.0 4284.6 4299.4 3776.5 3810.1 3839.7 3856.8 3879.4 4427.1 4436.0 4443.3 4479.7 4481.8 5139.0 5150.2 5150.5 5154.6 5163.3 4256.7 4347.2 4384.2 4405.6 4425.9 4630.6 4664.8 4665.5 4720.1 4724.5 4867.7 4873.0 4873.1 4876.6 4935.2 4927.1 4973.0 4984.6 5023.1 5164.7 4764.0 4767.5 4768.9 4809.1 4831.3 4961.3 4966.2 4966.4 4969.0 4996.5 5009.5 5026.4 5042.2 5049.1 5080.3 4920.0 4966.2 4968.0 5016.2 5024.1 4946.9 4960.0 4964.0 4964.2 5028.9 4686.8 4732.3 4888.4 4901.3 4908.8 4913.4 4932.5 4954.8 4980.1 5035.9 4769.6 4821.2 4828.9 4829.8 4838.9 05:29:48 INFO - PROCESS | 18009 | 05:29:48 INFO - PROCESS | 18009 | [#1] ext.html Cycles:180 Average:48049.88 Median:35568.88 stddev:92406.81 (259.8%) stddev-sans-first:92597.15 05:29:48 INFO - PROCESS | 18009 | Values: 528.5 558.7 580.6 584.5 584.9 27792.9 30796.7 30825.1 30850.1 30856.2 30216.8 38498.4 39278.8 39363.4 43401.3 7585.8 7730.8 7743.5 7752.5 7756.4 7601.3 7684.9 7691.0 7695.5 7695.5 7718.2 7752.8 7753.4 7754.5 7758.9 7683.8 7719.4 7736.1 7738.8 7739.4 7664.2 7670.4 7707.1 7723.8 7730.5 37455.3 37730.6 37772.4 37798.8 37839.0 3077.8 3084.2 3101.7 3211.7 3569.0 27513.4 27816.4 28010.6 28219.2 28968.7 3355.7 3391.2 3430.5 3500.9 3526.3 233562.0 234004.0 234632.0 234954.0 235847.0 51232.7 51348.0 51405.0 51447.7 51466.2 31424.5 32214.7 32279.0 34385.1 34448.7 13825.9 14079.9 14098.7 14107.9 14143.9 10415.5 10628.5 10678.7 10693.5 10714.7 17819.9 17874.0 18016.9 18032.8 18172.7 6562.7 6689.5 6760.5 6785.7 6883.7 761.3 826.2 880.4 920.9 995.8 26268.9 27736.3 28120.4 28298.3 28308.0 749.4 911.9 923.1 936.3 996.5 13254.0 14541.5 14661.7 14733.6 14782.6 363675.0 388841.0 393534.0 395881.0 579783.0 49195.0 49731.5 49812.8 49838.3 49903.8 1070.6 1075.7 1144.5 1177.8 1182.7 27708.0 31160.2 31182.2 31540.4 31632.2 46117.0 46861.3 46882.3 46887.1 46889.3 349568.0 350799.0 351160.0 353444.0 353453.0 24139.2 25207.9 30968.7 31639.8 34195.8 37076.4 37611.0 41149.6 41401.8 41624.5 35417.5 35438.1 35512.1 35999.5 36027.0 35625.6 35753.8 35820.3 36023.0 36032.6 34305.7 34866.3 35044.8 35690.8 38110.4 30167.2 32702.5 32762.2 32793.5 33060.0 24396.5 24774.6 24932.6 25126.2 25326.6 05:29:48 INFO - PROCESS | 18009 | 05:29:48 INFO - PROCESS | 18009 | [#2] jquery.html Cycles:180 Average:22713.48 Median:4636.49 stddev:58356.96 (1258.6%) stddev-sans-first:58496.49 05:29:48 INFO - PROCESS | 18009 | Values: 345.3 370.4 377.1 379.3 387.8 12470.3 15466.3 15527.4 16534.8 17664.2 16441.2 17311.7 17334.8 17377.7 17503.1 5058.2 5071.0 5083.8 5097.8 5098.1 3711.4 3905.7 5060.6 5150.9 5878.6 6130.8 6236.3 6244.9 6263.4 6263.8 5064.4 5311.8 5330.2 5413.6 6240.2 5243.5 5246.4 5246.5 5264.0 5264.4 11538.4 11786.2 12179.7 12283.4 13440.7 1842.6 1869.3 1872.8 1922.1 1930.2 8518.6 8862.2 8996.3 9377.3 9499.2 1772.7 1774.6 1778.6 1779.2 1785.4 68891.0 69370.3 70228.0 70822.6 72406.6 9540.0 9638.8 9866.8 9930.4 10091.6 13291.8 13308.6 13316.9 13321.7 13354.2 6233.8 6611.5 6749.7 7035.8 7036.1 6385.4 6424.4 6464.3 6595.9 6604.8 4056.9 4091.2 4136.6 4204.5 4214.8 1787.9 1793.5 1803.1 1808.3 1815.1 714.3 831.1 853.4 876.9 963.1 15924.4 16527.3 16798.7 17321.3 17489.6 811.4 819.6 842.4 845.7 918.7 6836.6 9390.2 9609.3 9666.3 9667.6 345974.0 350863.0 354832.0 356029.0 356127.0 54904.7 58440.0 68429.3 69584.0 75360.6 806.2 830.9 835.6 841.2 887.4 14723.0 15529.8 16014.7 16335.2 16452.1 29281.7 38129.4 38619.4 39448.6 39927.6 51653.7 52402.5 52408.0 52778.5 53301.0 7248.5 7731.6 7743.5 7773.7 8010.0 11002.2 11799.8 11957.7 12142.0 12218.2 9893.2 10030.3 10202.3 10273.5 10511.6 10132.3 10235.3 10304.3 10454.7 10555.0 10372.6 10378.7 10540.2 10613.2 10879.2 6764.3 7228.5 7269.6 7561.5 8080.2 9979.0 10084.3 10237.1 10658.7 10686.9 05:29:48 INFO - PROCESS | 18009 | 05:29:48 INFO - PROCESS | 18009 | [#3] mootools.html Cycles:180 Average:5178.19 Median:5174.96 stddev:2975.95 (57.5%) stddev-sans-first:2970.49 05:29:48 INFO - PROCESS | 18009 | Values: 1363.7 1402.6 1467.7 1667.0 1677.5 7782.4 8289.4 8300.1 8303.8 8305.7 6709.9 6959.1 7655.0 7857.1 7885.0 2050.1 2056.6 2067.3 2076.1 2081.7 2073.1 2118.0 2118.5 2149.0 2160.8 1846.2 1913.2 2113.7 2199.3 2206.7 2165.5 2170.7 2174.1 2175.2 2177.0 2138.6 2138.9 2142.0 2143.2 2145.9 8129.1 8141.7 8180.0 8208.1 8210.8 4559.7 4575.8 4596.1 4617.2 4627.7 2832.2 3080.1 3086.9 3087.7 3094.0 884.7 930.4 933.3 946.0 962.1 11062.0 11123.9 11169.2 11204.7 11213.0 4031.1 4203.0 4290.8 4376.1 4411.7 9408.9 9423.1 9433.7 9438.2 9438.8 4533.3 4554.4 4557.9 4559.7 4560.8 4068.8 4082.7 4085.3 4085.3 4087.5 3648.0 3738.7 3849.7 3868.3 3972.8 1180.4 1212.2 1220.5 1224.5 1235.5 645.7 693.7 760.7 764.9 765.0 4903.6 5008.5 5015.1 5022.8 5140.0 810.8 822.0 848.9 876.7 885.7 3175.3 3393.5 3433.2 3458.8 3478.3 9417.5 9706.6 9800.4 9884.5 9892.6 9703.9 9732.2 9836.0 9852.7 9869.9 6952.7 7362.6 7404.0 7480.0 7489.3 5043.1 5209.9 5241.4 5333.3 5377.5 8718.1 8991.0 9097.0 9171.9 9216.7 9108.3 9223.3 9284.9 9311.4 9360.9 6736.4 6847.2 6855.7 6857.3 6861.7 7572.0 7587.6 7604.5 7664.3 7690.4 6942.4 6949.3 6955.2 6993.9 7014.5 6747.4 6756.8 6782.1 6789.8 6824.8 5858.2 5952.2 5960.8 5963.8 5965.5 4258.2 4449.6 4473.1 4504.9 4648.5 4362.6 4363.5 4540.2 4548.1 4549.5 05:29:48 INFO - PROCESS | 18009 | 05:29:48 INFO - PROCESS | 18009 | [#4] prototype.html Cycles:180 Average:4180.04 Median:4715.56 stddev:1228.48 (26.1%) stddev-sans-first:1196.72 05:29:48 INFO - PROCESS | 18009 | Values: 289.7 291.3 299.1 300.2 300.6 4854.9 4909.8 4935.9 4940.7 4950.8 4851.7 4852.9 4884.7 4900.7 4909.4 3860.7 3878.7 3884.3 3890.8 3893.7 3747.8 3806.0 3882.7 3885.7 3890.2 3787.7 3788.9 3808.4 3820.3 3827.3 3780.8 3784.6 3789.0 3790.2 3802.6 3141.0 3240.2 3370.8 3378.3 3381.4 4598.1 4667.5 4699.4 4713.2 4717.9 4311.5 4313.1 4327.6 4346.7 4349.3 4737.9 4803.4 5045.6 5048.1 5110.2 3638.1 3649.9 3660.7 3679.1 3708.6 5239.6 5278.6 5288.9 5294.3 5296.5 3593.3 3705.3 3730.1 3736.4 3744.2 3785.7 3799.1 3807.3 3809.5 3814.9 4283.7 4286.4 4286.5 4292.8 4306.8 5072.2 5076.4 5110.7 5114.4 5127.7 1289.2 1311.1 1311.9 1313.1 1313.8 824.2 829.4 849.5 852.1 853.8 3957.5 4009.9 4032.1 4040.7 4042.7 4603.4 4605.2 4614.8 4618.9 4637.1 4013.4 4023.3 4038.2 4046.8 4053.8 2294.0 2487.9 2490.3 2492.0 2497.8 4452.1 4454.8 4722.7 4861.7 4870.6 5222.5 5234.9 5251.7 5258.3 5373.9 4973.7 4975.0 4996.3 4998.5 5000.7 5070.6 5228.8 5265.8 5269.0 5304.3 5117.7 5123.3 5124.3 5160.2 5179.4 4950.3 4968.1 4968.4 4973.4 4989.7 3613.3 3691.6 3724.4 3736.8 3752.1 5276.9 5277.3 5281.8 5325.8 5328.9 5142.5 5146.4 5152.6 5155.4 5162.5 4883.0 5117.8 5148.2 5161.5 5184.7 5039.7 5049.6 5052.8 5064.2 5072.3 5176.0 5193.3 5204.9 5208.5 5220.0 4741.4 4932.4 4963.5 4967.9 4976.6 05:29:48 INFO - PROCESS | 18009 | 05:29:48 INFO - PROCESS | 18009 | [#5] yui.html Cycles:180 Average:17854.83 Median:4292.27 stddev:25370.14 (591.1%) stddev-sans-first:25408.42 05:29:48 INFO - PROCESS | 18009 | Values: 649.4 700.0 731.3 748.5 753.8 12404.5 13363.5 13365.6 13379.7 13400.5 12801.7 12812.7 12815.7 12844.3 12866.8 617.2 633.0 635.0 752.4 781.1 631.1 752.5 769.5 770.5 776.5 807.5 818.9 819.4 819.4 819.5 815.4 817.4 817.5 817.6 817.9 474.0 480.4 578.8 599.7 600.4 12212.7 12824.9 12839.6 12879.9 12882.1 12464.6 12678.8 12857.4 13119.5 13549.7 11142.2 11441.6 11520.2 11573.9 12163.9 4080.8 4100.1 4158.8 4289.5 4291.5 52806.5 55497.2 55838.0 64254.0 64331.0 10152.2 10172.4 10550.7 10764.2 11048.8 18978.2 18998.6 19006.2 19204.2 19359.5 7048.9 7102.9 7192.6 7197.8 7432.1 3732.5 3885.4 3894.6 3897.4 3916.2 2922.1 3029.8 3044.0 3044.9 3048.6 516.8 522.5 523.0 530.7 541.1 480.6 590.0 591.4 619.5 647.7 8047.6 8164.0 8332.5 8429.2 8511.1 483.4 493.5 555.6 592.2 605.2 3908.8 4108.1 4263.3 4293.0 4303.9 96032.5 97839.0 98287.5 98991.5 99205.5 85174.6 89714.9 90621.5 91171.0 92303.0 72351.0 72525.0 74469.6 74684.3 74770.3 7458.4 7953.5 7964.7 7990.8 8191.3 40525.4 41031.2 41391.4 41487.4 42841.4 55436.4 58831.1 61362.5 63866.0 64291.4 11266.2 11270.8 11304.3 11950.3 12301.8 13003.7 13393.9 13567.5 13956.7 14410.5 12131.1 12271.5 12347.6 12625.9 12640.4 10699.4 11683.0 11824.5 12449.5 12869.4 11512.8 12412.0 12739.5 12741.2 13432.7 9947.7 10003.3 10551.4 11188.4 11337.4 9800.6 10126.6 10168.2 10170.4 10267.2 05:29:48 INFO - PROCESS | 18009 | -------- Summary: end -------- 05:29:48 INFO - PROCESS | 18009 | 05:29:49 INFO - TEST-INFO | 18009: exit 0 05:29:49 INFO - TEST-OK | dromaeo_css | took 1122173ms 05:29:49 INFO - TEST-START | kraken 05:29:49 INFO - operating with platform_type : linux_ 05:29:49 INFO - Initialising browser for kraken test... 05:29:49 INFO - TEST-INFO | started process 18317 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKNIYRJ/profile http://localhost:50770/getInfo.html) 05:29:54 INFO - PROCESS | 18317 | __metrics Screen width/height:1600/1200 05:29:54 INFO - PROCESS | 18317 | colorDepth:24 05:29:54 INFO - PROCESS | 18317 | Browser inner width/height: 1024/697 05:29:54 INFO - PROCESS | 18317 | __metrics 05:29:54 INFO - PROCESS | 18317 | 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" 05:29:54 INFO - PROCESS | 18317 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:29:55 INFO - PROCESS | 18317 | console.error: PushService: 05:29:55 INFO - PROCESS | 18317 | stateChangeProcessEnqueue: Error transitioning state 05:29:55 INFO - PROCESS | 18317 | UnknownError 05:29:55 INFO - TEST-INFO | 18317: exit 0 05:29:55 INFO - Browser initialized. 05:29:55 INFO - Running cycle 1/1 for kraken test... 05:29:55 INFO - TEST-INFO | started process 18398 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKNIYRJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:30:08 INFO - PROCESS | 18398 | RSS: Main: 175333376 05:30:08 INFO - PROCESS | 18398 | 05:30:11 INFO - PROCESS | 18398 | Cycle 1(1): loaded http://localhost:50770/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50770/tests/kraken/driver.html?testName=audio-beat-detection) 05:30:11 INFO - PROCESS | 18398 | RSS: Main: 234233856 05:30:11 INFO - PROCESS | 18398 | 05:30:14 INFO - PROCESS | 18398 | Cycle 1(1): loaded http://localhost:50770/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50770/tests/kraken/driver.html?testName=audio-dft) 05:30:15 INFO - PROCESS | 18398 | RSS: Main: 218730496 05:30:15 INFO - PROCESS | 18398 | 05:30:18 INFO - PROCESS | 18398 | Cycle 1(1): loaded http://localhost:50770/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50770/tests/kraken/driver.html?testName=audio-fft) 05:30:19 INFO - PROCESS | 18398 | RSS: Main: 300912640 05:30:19 INFO - PROCESS | 18398 | 05:30:21 INFO - PROCESS | 18398 | Cycle 1(1): loaded http://localhost:50770/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50770/tests/kraken/driver.html?testName=audio-oscillator) 05:30:22 INFO - PROCESS | 18398 | RSS: Main: 210219008 05:30:22 INFO - PROCESS | 18398 | 05:30:24 INFO - PROCESS | 18398 | Cycle 1(1): loaded http://localhost:50770/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50770/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:30:24 INFO - PROCESS | 18398 | RSS: Main: 213172224 05:30:24 INFO - PROCESS | 18398 | 05:30:28 INFO - PROCESS | 18398 | Cycle 1(1): loaded http://localhost:50770/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50770/tests/kraken/driver.html?testName=imaging-darkroom) 05:30:28 INFO - PROCESS | 18398 | RSS: Main: 250843136 05:30:28 INFO - PROCESS | 18398 | 05:30:32 INFO - PROCESS | 18398 | Cycle 1(1): loaded http://localhost:50770/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50770/tests/kraken/driver.html?testName=imaging-desaturate) 05:30:32 INFO - PROCESS | 18398 | RSS: Main: 244563968 05:30:32 INFO - PROCESS | 18398 | 05:30:35 INFO - PROCESS | 18398 | Cycle 1(1): loaded http://localhost:50770/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50770/tests/kraken/driver.html?testName=json-parse-financial) 05:30:36 INFO - PROCESS | 18398 | RSS: Main: 247185408 05:30:36 INFO - PROCESS | 18398 | 05:30:38 INFO - PROCESS | 18398 | Cycle 1(1): loaded http://localhost:50770/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50770/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:30:38 INFO - PROCESS | 18398 | RSS: Main: 210993152 05:30:38 INFO - PROCESS | 18398 | 05:30:40 INFO - PROCESS | 18398 | Cycle 1(1): loaded http://localhost:50770/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50770/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:30:41 INFO - PROCESS | 18398 | RSS: Main: 217735168 05:30:41 INFO - PROCESS | 18398 | 05:30:43 INFO - PROCESS | 18398 | Cycle 1(1): loaded http://localhost:50770/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50770/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:30:44 INFO - PROCESS | 18398 | RSS: Main: 222736384 05:30:44 INFO - PROCESS | 18398 | 05:30:46 INFO - PROCESS | 18398 | Cycle 1(1): loaded http://localhost:50770/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50770/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:30:47 INFO - PROCESS | 18398 | RSS: Main: 223985664 05:30:47 INFO - PROCESS | 18398 | 05:30:50 INFO - PROCESS | 18398 | Cycle 1(1): loaded http://localhost:50770/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50770/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:30:51 INFO - PROCESS | 18398 | RSS: Main: 221843456 05:30:51 INFO - PROCESS | 18398 | 05:30:52 INFO - PROCESS | 18398 | Cycle 1(1): loaded http://localhost:50770/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50770/tests/kraken/driver.html?testName=ai-astar) 05:30:53 INFO - PROCESS | 18398 | RSS: Main: 273334272 05:30:53 INFO - PROCESS | 18398 | 05:30:53 INFO - PROCESS | 18398 | __start_tp_report 05:30:53 INFO - PROCESS | 18398 | _x_x_mozilla_page_load 05:30:53 INFO - PROCESS | 18398 | _x_x_mozilla_page_load_details 05:30:53 INFO - PROCESS | 18398 | |i|pagename|runs| 05:30:53 INFO - PROCESS | 18398 | |0;ai-astar;113;113;113;114;114;114;115;114;113;115 05:30:53 INFO - PROCESS | 18398 | |1;audio-beat-detection;158;126;124;164;129;127;123;123;163;124 05:30:53 INFO - PROCESS | 18398 | |2;audio-dft;162;162;164;162;162;161;162;162;161;164 05:30:53 INFO - PROCESS | 18398 | |3;audio-fft;77;76;77;118;77;80;77;78;105;77 05:30:53 INFO - PROCESS | 18398 | |4;audio-oscillator;85;84;121;85;85;85;105;85;84;111 05:30:53 INFO - PROCESS | 18398 | |5;imaging-gaussian-blur;117;117;119;119;117;117;117;117;117;117 05:30:53 INFO - PROCESS | 18398 | |6;imaging-darkroom;147;146;147;147;147;148;147;147;148;147 05:30:53 INFO - PROCESS | 18398 | |7;imaging-desaturate;95;95;96;95;95;96;96;96;95;94 05:30:53 INFO - PROCESS | 18398 | |8;json-parse-financial;62;63;62;62;66;62;63;63;64;64 05:30:53 INFO - PROCESS | 18398 | |9;json-stringify-tinderbox;66;67;66;66;74;66;66;66;66;66 05:30:53 INFO - PROCESS | 18398 | |10;stanford-crypto-aes;84;84;83;82;82;84;83;82;83;82 05:30:53 INFO - PROCESS | 18398 | |11;stanford-crypto-ccm;134;134;133;140;134;133;133;133;165;145 05:30:53 INFO - PROCESS | 18398 | |12;stanford-crypto-pbkdf2;176;177;171;176;171;172;173;174;173;170 05:30:53 INFO - PROCESS | 18398 | |13;stanford-crypto-sha256-iterative;70;70;72;73;74;70;74;69;69;68 05:30:53 INFO - PROCESS | 18398 | __end_tp_report 05:30:53 INFO - PROCESS | 18398 | __start_cc_report 05:30:53 INFO - PROCESS | 18398 | _x_x_mozilla_cycle_collect,1942 05:30:53 INFO - PROCESS | 18398 | __end_cc_report 05:30:53 INFO - PROCESS | 18398 | __startTimestamp1474633853175__endTimestamp 05:30:53 INFO - PROCESS | 18398 | 05:30:53 INFO - PROCESS | 18398 | ------- Summary: start ------- 05:30:53 INFO - PROCESS | 18398 | Number of tests: 14 05:30:53 INFO - PROCESS | 18398 | 05:30:53 INFO - PROCESS | 18398 | [#0] ai-astar Cycles:10 Average:113.80 Median:114.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 05:30:53 INFO - PROCESS | 18398 | Values: 113.0 113.0 113.0 114.0 114.0 114.0 115.0 114.0 113.0 115.0 05:30:53 INFO - PROCESS | 18398 | 05:30:53 INFO - PROCESS | 18398 | [#1] audio-beat-detection Cycles:10 Average:136.10 Median:128.00 stddev:17.80 (13.9%) stddev-sans-first:17.03 05:30:53 INFO - PROCESS | 18398 | Values: 158.0 126.0 124.0 164.0 129.0 127.0 123.0 123.0 163.0 124.0 05:30:53 INFO - PROCESS | 18398 | 05:30:53 INFO - PROCESS | 18398 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:1.03 (0.6%) stddev-sans-first:1.09 05:30:53 INFO - PROCESS | 18398 | Values: 162.0 162.0 164.0 162.0 162.0 161.0 162.0 162.0 161.0 164.0 05:30:53 INFO - PROCESS | 18398 | 05:30:53 INFO - PROCESS | 18398 | [#3] audio-fft Cycles:10 Average:84.20 Median:77.00 stddev:14.75 (19.2%) stddev-sans-first:15.41 05:30:53 INFO - PROCESS | 18398 | Values: 77.0 76.0 77.0 118.0 77.0 80.0 77.0 78.0 105.0 77.0 05:30:53 INFO - PROCESS | 18398 | 05:30:53 INFO - PROCESS | 18398 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:85.00 stddev:13.88 (16.3%) stddev-sans-first:14.42 05:30:53 INFO - PROCESS | 18398 | Values: 85.0 84.0 121.0 85.0 85.0 85.0 105.0 85.0 84.0 111.0 05:30:53 INFO - PROCESS | 18398 | 05:30:53 INFO - PROCESS | 18398 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.84 (0.7%) stddev-sans-first:0.88 05:30:53 INFO - PROCESS | 18398 | Values: 117.0 117.0 119.0 119.0 117.0 117.0 117.0 117.0 117.0 117.0 05:30:53 INFO - PROCESS | 18398 | 05:30:53 INFO - PROCESS | 18398 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 05:30:53 INFO - PROCESS | 18398 | Values: 147.0 146.0 147.0 147.0 147.0 148.0 147.0 147.0 148.0 147.0 05:30:53 INFO - PROCESS | 18398 | 05:30:53 INFO - PROCESS | 18398 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 05:30:53 INFO - PROCESS | 18398 | Values: 95.0 95.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 94.0 05:30:53 INFO - PROCESS | 18398 | 05:30:53 INFO - PROCESS | 18398 | [#8] json-parse-financial Cycles:10 Average:63.10 Median:63.00 stddev:1.29 (2.0%) stddev-sans-first:1.30 05:30:53 INFO - PROCESS | 18398 | Values: 62.0 63.0 62.0 62.0 66.0 62.0 63.0 63.0 64.0 64.0 05:30:53 INFO - PROCESS | 18398 | 05:30:53 INFO - PROCESS | 18398 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:66.00 stddev:2.51 (3.8%) stddev-sans-first:2.65 05:30:53 INFO - PROCESS | 18398 | Values: 66.0 67.0 66.0 66.0 74.0 66.0 66.0 66.0 66.0 66.0 05:30:53 INFO - PROCESS | 18398 | 05:30:53 INFO - PROCESS | 18398 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:0.88 (1.1%) stddev-sans-first:0.83 05:30:53 INFO - PROCESS | 18398 | Values: 84.0 84.0 83.0 82.0 82.0 84.0 83.0 82.0 83.0 82.0 05:30:53 INFO - PROCESS | 18398 | 05:30:53 INFO - PROCESS | 18398 | [#11] stanford-crypto-ccm Cycles:10 Average:138.40 Median:134.00 stddev:10.16 (7.6%) stddev-sans-first:10.65 05:30:53 INFO - PROCESS | 18398 | Values: 134.0 134.0 133.0 140.0 134.0 133.0 133.0 133.0 165.0 145.0 05:30:53 INFO - PROCESS | 18398 | 05:30:53 INFO - PROCESS | 18398 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.30 Median:173.50 stddev:2.41 (1.4%) stddev-sans-first:2.35 05:30:53 INFO - PROCESS | 18398 | Values: 176.0 177.0 171.0 176.0 171.0 172.0 173.0 174.0 173.0 170.0 05:30:53 INFO - PROCESS | 18398 | 05:30:53 INFO - PROCESS | 18398 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:71.00 stddev:2.18 (3.1%) stddev-sans-first:2.29 05:30:53 INFO - PROCESS | 18398 | Values: 70.0 70.0 72.0 73.0 74.0 70.0 74.0 69.0 69.0 68.0 05:30:53 INFO - PROCESS | 18398 | -------- Summary: end -------- 05:30:53 INFO - PROCESS | 18398 | 05:30:54 INFO - TEST-INFO | 18398: exit 0 05:30:54 INFO - TEST-OK | kraken | took 65206ms 05:30:54 INFO - SUITE-END | took 1187s 05:30:54 INFO - Completed test suite (00:19:47) 05:30:54 INFO - javascript benchmark 05:30:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2606.296299999, 2638.419547699508, 2667.733226677332, 2674.318048897531, 2681.7184195659456, 4594.908101837961, 4697.765111744417, 4711.740854253015, 4811.518848115191, 4852.85441436757, 4683.882902927428, 4694.7183169009795, 4720.173969555322, 4732.432108147019, 4743.928841067387, 4276.593723596261, 4318.546552611978, 4400.801963911632, 4460.063386688783, 4466.0, 4315.697901146921, 4351.673624478161, 4362.32383980482, 4452.643788496929, 4476.12715520472, 4365.869023929287, 4400.537943515933, 4472.3515090311885, 4507.391502147218, 4520.457545094577, 4455.064436468346, 4473.194824931511, 4513.074819661962, 4521.163584736834, 4533.070720502289, 4279.529251782302, 4310.676699247538, 4314.072474418015, 4365.432493775789, 4414.271645178574, 4622.260438329851, 4650.674452788307, 4673.345731597579, 4679.883002924954, 4688.5077066907825, 4975.651704380694, 4987.700737955734, 5026.89946201074, 5038.370203724535, 5088.821891233789, 4955.876103097451, 5093.668911520739, 5094.133997220481, 5104.3619547556555, 5161.793528258865, 4655.650826188049, 4715.316279139505, 4766.547178018082, 4780.665353425227, 4791.496892826272, 5171.095058364771, 5197.298364720715, 5215.16557350822, 5223.738813059332, 5292.41783403833, 4889.731064791471, 5002.249662550574, 5005.924911126336, 5006.249062640561, 5008.273800298936, 5025.698458092526, 5081.0092032054135, 5110.1568241239775, 5124.5131712487255, 5218.7912483500995, 5079.492050794965, 5091.389033315952, 5099.974500127476, 5101.7704203310195, 5158.045761534128, 4783.856484305406, 5062.797488100435, 5064.974675126601, 5072.568831649277, 5124.641275110781, 4225.133847561243, 4274.252005899018, 4278.978605107017, 4284.635805956528, 4299.355096735515, 3776.5090538229856, 3810.0855794609647, 3839.6544311012144, 3856.8071596420627, 3879.4374815652136, 4427.136708341907, 4435.977820110943, 4443.33349997503, 4479.686421950432, 4481.798319075584, 5138.974305128525, 5150.175971844562, 5150.510701483353, 5154.613403994716, 5163.328767260232, 4256.723312984646, 4347.239233134189, 4384.167008268419, 4405.559444055633, 4425.889352766207, 4630.58324750774, 4664.790084446208, 4665.533446655308, 4720.103180395714, 4724.503927087675, 4867.70793752376, 4872.951270487391, 4873.074115917964, 4876.561109500091, 4935.235038568884, 4927.1131196384995, 4973.030259099585, 4984.576311013604, 5023.146065169003, 5164.690118592896, 4764.047190561971, 4767.523247675344, 4768.880777980578, 4809.0862736080035, 4831.323614693875, 4961.255811628284, 4966.180580204225, 4966.354373931365, 4968.975155124202, 4996.475370086088, 5009.474005229544, 5026.371703537058, 5042.243663450365, 5049.116404629249, 5080.314157588678, 4919.975400122977, 4966.155753521838, 4967.975160124176, 5016.197408414636, 5024.070546948826, 4946.901061978812, 4960.032793605213, 4964.0, 4964.205727083649, 5028.874278143076, 4686.8125274988615, 4732.313814496947, 4888.413390393175, 4901.264810278487, 4908.828191013297, 4913.361263035782, 4932.457429682804, 4954.777035033504, 4980.103581355391, 5035.899282014266, 4769.642276829182, 4821.228603423436, 4828.8792780180775, 4829.7585120744525, 4838.879028024327], "value": 4670.660736026408, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [528.5428104689445, 558.6759679385957, 580.6312991250558, 584.5498965796337, 584.8947189505892, 27792.86103569482, 30796.692033079664, 30825.07524774255, 30850.074497765047, 30856.228594285127, 30216.848915755447, 38498.422523662164, 39278.80360598193, 39363.40954885672, 43401.34897976533, 7585.848283034336, 7730.8453830923345, 7743.4966727162555, 7752.534847909115, 7756.418268629847, 7601.315881570657, 7684.885691574718, 7691.038620172479, 7695.538267703928, 7695.538267703928, 7718.151003389623, 7752.844943101135, 7753.379729621645, 7754.534727916315, 7758.883616745753, 7683.846323073535, 7719.38244940409, 7736.071671399412, 7738.806529836743, 7739.419543534257, 7664.233576642347, 7670.386369090459, 7707.113681926538, 7723.845523089507, 7730.536167829948, 37455.25089498222, 37730.62269377299, 37772.43341349882, 37798.81100594479, 37839.0, 3077.830719310437, 3084.228942764309, 3101.72084512395, 3211.74306055515, 3568.964310356889, 27513.44973100547, 27816.443671126668, 28010.57984130219, 28219.153425397064, 28968.710312896812, 3355.7315414767004, 3391.173833571945, 3430.485427185917, 3500.8949731508096, 3526.2947410518, 233562.0, 234004.0, 234631.99999999828, 234954.0, 235847.0, 51232.74383628058, 51348.0, 51405.0, 51447.7427612867, 51466.22800657993, 31424.528632070538, 32214.677853221638, 32279.0, 34385.140371490415, 34448.65551344505, 13825.861741382658, 14079.859201407855, 14098.718025639635, 14107.929460352632, 14143.858561414254, 10415.479226038668, 10628.521716522775, 10678.73303167427, 10693.465326733633, 10714.732131696614, 17819.910900445673, 17874.0, 18016.9099154506, 18032.819671803376, 18172.727409088875, 6562.704678289393, 6689.531732778756, 6760.492963027694, 6785.694643741043, 6883.690233939485, 761.2958013837178, 826.1614461321764, 880.3749337969984, 920.8572671235969, 995.7908839143861, 26268.8686556566, 27736.306592335353, 28120.43759124806, 28298.292542686188, 28308.0, 749.3630414147931, 911.9179273865251, 923.1184219070772, 936.2556767369957, 996.4917891875195, 13254.0, 14541.491047813275, 14661.706765864623, 14733.55799326022, 14782.556523304318, 363675.0, 388841.0, 393534.0, 395881.0, 579783.0, 49195.0, 49731.502684972686, 49812.75093624509, 49838.252426213636, 49903.75048124736, 1070.5931745936493, 1075.736444571085, 1144.4849817582121, 1177.776222517719, 1182.6688527212393, 27708.0, 31160.220994474414, 31182.22044448816, 31540.36919261648, 31632.209194770316, 46117.0, 46861.29708054314, 46882.296765547864, 46887.062258755315, 46889.296660550805, 349568.0, 350799.0, 351160.0, 353444.0, 353453.0, 24139.15512957038, 25207.87396063008, 30968.69031309658, 31639.841800790848, 34195.82902085573, 37076.44385334168, 37611.0, 41149.588504114574, 41401.792991036054, 41624.50252984831, 35417.468737969466, 35438.11404714903, 35512.11219719424, 35999.46000809938, 36027.0, 35625.643743562236, 35753.82123089368, 35820.28359432745, 36023.0, 36032.639673603975, 34305.65694343125, 34866.302673946884, 35044.82477587596, 35690.821545892104, 38110.428343575426, 30167.245818853826, 32702.509462357608, 32762.180945476553, 32793.50809737904, 33060.0, 24396.51206975886, 24774.628380573944, 24932.626010609492, 25126.246212613652, 25326.620100698874], "value": 17099.446882561075, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.2611411579222, 370.36297568182715, 377.0705211653274, 379.2528718424703, 387.778965989386, 12470.251784892902, 15466.304016319264, 15527.378904843821, 16534.7519787203, 17664.205110770014, 16441.177941102927, 17311.74032389512, 17334.826651733478, 17377.73933391, 17503.124843757825, 5058.190689489682, 5071.036503064415, 5083.79664813407, 5097.827499675077, 5098.082345177866, 3711.4247291669835, 3905.6875449963936, 5060.620453465986, 5150.871228219287, 5878.617889837147, 6130.754769809202, 6236.251649802008, 6244.87510249797, 6263.404976527246, 6263.812085637415, 5064.392272927235, 5311.787528498855, 5330.173823057432, 5413.621046526745, 6240.157578726882, 5243.501867322599, 5246.449122842123, 5246.501582349671, 5263.973680131575, 5264.447233040552, 11538.365389903553, 11786.233894796811, 12179.695507612292, 12283.447244874002, 13440.731185376335, 1842.6406850664125, 1869.2709843161178, 1872.8354629817838, 1922.0677971183964, 1930.2182616040527, 8518.616662250151, 8862.158094980967, 8996.280297576179, 9377.29670274732, 9499.24006079512, 1772.7340898865145, 1774.5652315182863, 1778.5731424458038, 1779.24382137591, 1785.4199033855002, 68891.0, 69370.30629693689, 70228.00197611666, 70822.64588677076, 72406.63796680982, 9539.952300238454, 9638.759031024281, 9866.785962819424, 9930.404175749478, 10091.646792362379, 13291.800622990662, 13308.600741977756, 13316.933415332862, 13321.733565328639, 13354.198748075147, 6233.750649974041, 6611.471082313404, 6749.730010799513, 7035.8241043973285, 7036.050133232051, 6385.425311721968, 6424.421802037839, 6464.321246269168, 6595.85634668725, 6604.834879127964, 4056.8985775355854, 4091.243120022805, 4136.607022332873, 4204.495460544754, 4214.789260536961, 1787.9463616091539, 1793.4798908316702, 1803.1435068342432, 1808.2586139682667, 1815.0652414006797, 714.3249629100554, 831.094107422912, 853.4239388412797, 876.8860048193822, 963.1235575626287, 15924.363025478851, 16527.33890644385, 16798.664026719398, 17321.30714771395, 17489.562760930825, 811.3792948394483, 819.5983967855827, 842.3555979675554, 845.691322667222, 918.7014220378404, 6836.555623884432, 9390.201832844148, 9609.279304052085, 9666.323357365058, 9667.564959576835, 345974.0, 350863.0, 354832.0, 356029.0, 356127.0, 54904.72547637236, 58440.0, 68429.31570684329, 69584.0, 75360.62319688367, 806.1978331560135, 830.8587540118074, 835.5571547080058, 841.1840514700853, 887.3699673231948, 14723.0, 15529.76705349398, 16014.67970640604, 16335.183240837672, 16452.095134767704, 29281.707182927898, 38129.42805857859, 38619.420708689955, 39448.605513944494, 39927.600723992386, 51653.741731291106, 52402.47597524129, 52408.0, 52778.472215277354, 53301.0, 7248.456365772483, 7731.613419329124, 7743.4966727162555, 7773.650185741542, 8010.0, 11002.229843910849, 11799.76400472003, 11957.701057473632, 12142.028637709138, 12218.20581662189, 9893.208543316374, 10030.29787914839, 10202.285839991426, 10273.486325683836, 10511.579536818748, 10132.34139780912, 10235.283530152818, 10304.330218535772, 10454.68635940923, 10555.0, 10372.58509659605, 10378.740531486774, 10540.156787456832, 10613.20400969915, 10879.1840611956, 6764.323567643196, 7228.457865660202, 7269.600171990592, 7561.546307221364, 8080.151584083822, 9979.0, 10084.344517606332, 10237.129843963347, 10658.680239592824, 10686.946565267435], "value": 7934.573248914271, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1363.6999860030792, 1402.5722154742805, 1467.7250262093758, 1667.049781624473, 1677.4883660483547, 7782.377409807216, 8289.378296627747, 8300.086990431048, 8303.750887473378, 8305.709300174494, 6709.899351509731, 6959.130108736408, 7654.961725191366, 7857.135715071352, 7884.960575197116, 2050.1082029317295, 2056.5784014277037, 2067.266120527214, 2076.0761461149796, 2081.7189679393314, 2073.1085633177727, 2117.978820211801, 2118.5233322502468, 2148.967765483519, 2160.8487405881597, 1846.150770645498, 1913.2347061175572, 2113.6723807809735, 2199.2632468123197, 2206.7020952171492, 2165.4911095892453, 2170.696102545645, 2174.1086154676505, 2175.249538909082, 2177.0421014753456, 2138.636431806581, 2138.9251376201914, 2141.957160856774, 2143.239150101707, 2145.8927053647253, 8129.105798362176, 8141.674333026672, 8180.0, 8208.138145494697, 8210.794730131734, 4559.680822342404, 4575.816967321303, 4596.1267359201975, 4617.215073437524, 4627.676062675614, 2832.1503548935443, 3080.1067690369764, 3086.861091250899, 3087.6757940416383, 3093.9845300773577, 884.7168905950099, 930.432436213909, 933.3186773655269, 945.9905400945971, 962.1052421248237, 11062.0, 11123.888761112446, 11169.162312826571, 11204.719882002933, 11212.999999999918, 4031.133306339151, 4202.957970420318, 4290.849820256276, 4376.124775045004, 4411.691181617321, 9408.858867116998, 9423.05769423066, 9433.716988490356, 9438.197753190918, 9438.811223775487, 4533.32000199966, 4554.362389265505, 4557.863264102082, 4559.703619264737, 4560.817567297271, 4068.8372465101656, 4082.6529744971417, 4085.2850751118435, 4085.346344584852, 4087.529934057562, 3647.9635203648154, 3738.7009039277336, 3849.730518863653, 3868.323043467382, 3972.801359931992, 1180.3979970215253, 1212.1999480342931, 1220.530095913062, 1224.5469176404788, 1235.5057976809169, 645.686841881687, 693.6947742993067, 760.7261385901071, 764.8661484240235, 764.9732259370895, 4903.607711383081, 5008.474110218447, 5015.072211640858, 5022.773975171126, 5140.023395554833, 810.8175660476346, 821.9917800821916, 848.9151084891462, 876.7194497760655, 885.6723012485421, 3175.3173067790076, 3393.5079413484905, 3433.1588760753275, 3458.75788694794, 3478.2695633916655, 9417.529123543796, 9706.563204655808, 9800.36297640651, 9884.456354900405, 9892.604295828087, 9703.854442183372, 9732.2214222862, 9836.0, 9852.704418867446, 9869.851952220723, 6952.721891124298, 7362.558246505227, 7404.0, 7480.0, 7489.251074892576, 5043.142665746758, 5209.895802084013, 5241.371035475768, 5333.333333333333, 5377.516023557899, 8718.08460111679, 8990.955045224731, 9097.0, 9171.908280917372, 9216.677416290398, 9108.316876234176, 9223.30825188127, 9284.907150928404, 9311.394759340621, 9360.859587106062, 6736.360045795642, 6847.1783385994, 6855.725770969106, 6857.348551887562, 6861.725530978904, 7571.962140189264, 7587.58268295249, 7604.467687261838, 7664.34853037498, 7690.384769218561, 6942.375186233263, 6949.30506949301, 6955.234924158237, 6993.895091573732, 7014.508984371045, 6747.359000894907, 6756.763513277012, 6782.118324617768, 6789.762358317633, 6824.7952561423235, 5858.150568167677, 5952.226210592596, 5960.791372301948, 5963.761449541969, 5965.492933100735, 4258.233517966796, 4449.599536041772, 4473.105378924293, 4504.9099018020115, 4648.465426475998, 4362.563743625612, 4363.541828108003, 4540.160070386989, 4548.135854187693, 4549.45406551216], "value": 4130.150399177271, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.743576934413, 291.3401146403396, 299.08181881623426, 300.1610498656256, 300.5761875755184, 4854.907645779702, 4909.803607855691, 4935.851924442263, 4940.678855874366, 4950.826721064764, 4851.684640498374, 4852.854414367565, 4884.658073934817, 4900.730459824708, 4909.386326709161, 3860.6718428933573, 3878.6703130233964, 3884.261990221863, 3890.8249128789203, 3893.669038131762, 3747.812609369534, 3806.015351160273, 3882.7476214046137, 3885.7279990400684, 3890.2414029264305, 3787.696984241254, 3788.905277368074, 3808.447775072613, 3820.2741479119018, 3827.349350610389, 3780.8487660493684, 3784.6215378462207, 3788.9621103788886, 3790.2040571480024, 3802.619738026175, 3141.0, 3240.2061494933655, 3370.7808992415416, 3378.2905589826164, 3381.357542067024, 4598.137754209551, 4667.509911459282, 4699.368353721927, 4713.198756211418, 4717.9292310615365, 4311.482622085338, 4313.0726893718, 4327.567243275679, 4346.717463364871, 4349.260625693608, 4737.857864264078, 4803.351547541072, 5045.6215783816, 5048.072118171452, 5110.233464980245, 3638.1450359165574, 3649.8830678206577, 3660.652238037382, 3679.1170119171475, 3708.554973403182, 5239.633225674204, 5278.604104692164, 5288.867778305573, 5294.338207724035, 5296.470352964711, 3593.2633810068874, 3705.333040052816, 3730.1420673245307, 3736.4021756518828, 3744.1762812181278, 3785.73499855013, 3799.145192331703, 3807.2956503047026, 3809.5238095238096, 3814.8855534334016, 4283.700140990163, 4286.39990401344, 4286.507051689034, 4292.785360731951, 4306.784660766949, 5072.213806859869, 5076.44159142494, 5110.71891045996, 5114.360704911886, 5127.666701664454, 1289.2264641215195, 1311.0691409099456, 1311.9081664283408, 1313.1267706974945, 1313.8160657507956, 824.2458150791958, 829.369679043919, 849.5327569836566, 852.071242345846, 853.8227519824422, 3957.465742124834, 4009.9373665978537, 4032.117036319046, 4040.7373520721058, 4042.6765858731233, 4603.401557797465, 4605.217113090783, 4614.792334344963, 4618.85223371134, 4637.124982510865, 4013.3712418366017, 4023.255697695877, 4038.1519880825354, 4046.838126474967, 4053.777042262645, 2293.9655905161435, 2487.863167525767, 2490.340059884132, 2492.0405643827257, 2497.7627125423055, 4452.12837719669, 4454.844080457168, 4722.693024953367, 4861.6596838220985, 4870.586000190024, 5222.477752224747, 5234.895302093937, 5251.737413129405, 5258.2638430619745, 5373.892522149535, 4973.676711013773, 4975.0, 4996.275540046673, 4998.500149984972, 5000.67495612784, 5070.5943524517215, 5228.843134705965, 5265.815696450759, 5269.0, 5304.257403963526, 5117.744112794271, 5123.282740416419, 5124.333836601218, 5160.174372100446, 5179.378474583074, 4950.306957025947, 4968.130577148912, 4968.428630707371, 4973.35346404965, 4989.650724449254, 3613.313470440608, 3691.6123807000954, 3724.385476396364, 3736.7757934524016, 3752.1182522106737, 5276.920846187233, 5277.340332458442, 5281.788728450819, 5325.786968521215, 5328.8934221314585, 5142.537171654569, 5146.433892271922, 5152.5877929766275, 5155.407128180307, 5162.5095615916425, 4882.951170488392, 5117.769700363567, 5148.176291793295, 5161.509656582619, 5184.688918664892, 5039.748012599429, 5049.596032317332, 5052.823151189691, 5064.240363945438, 5072.28987941681, 5175.95549757851, 5193.298904647824, 5204.869878253074, 5208.5312321891215, 5220.0, 4741.407324084489, 4932.4081110267, 4963.468630998144, 4967.875803104951, 4976.552110310089], "value": 3788.6835756404157, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.4252586460982, 699.9580025198488, 731.3138910055317, 748.5433885329948, 753.8040109571509, 12404.503819847207, 13363.465461381546, 13365.599032029055, 13379.665508362285, 13400.530981415652, 12801.679958001032, 12812.679683007906, 12815.743685126292, 12844.293563853984, 12866.806997895015, 617.2038070888549, 633.0188208277152, 635.0347471842796, 752.3755283115029, 781.0510230070463, 631.1321932343028, 752.4995877741295, 769.4575324396316, 770.4645271536284, 776.4603600497657, 807.4630370803409, 818.8976377952756, 819.3527113580265, 819.4386845011186, 819.5082950229875, 815.4332738746574, 817.4032955942166, 817.5421763812225, 817.5707753429467, 817.8936738224053, 474.0116856354505, 480.4162942025456, 578.7800635758427, 599.6522017230039, 600.3546187848037, 12212.694682632917, 12824.87175128246, 12839.614811555668, 12879.935600321938, 12882.098253122285, 12464.563740269046, 12678.80981785274, 12857.4214160363, 13119.540816071392, 13549.661258468617, 11142.220044596881, 11441.599544015919, 11520.193586448951, 11573.942130289295, 12163.878361216362, 4080.775557344345, 4100.0569868930015, 4158.83552605268, 4289.52815190332, 4291.549387314319, 52806.471935280926, 55497.167542486895, 55838.0, 64254.03618945766, 64331.0, 10152.187824973984, 10172.389656620626, 10550.736231594117, 10764.192685548458, 11048.834267485994, 18978.240870365305, 18998.620027599372, 19006.23975040983, 19204.231830726894, 19359.516012099528, 7048.859022819617, 7102.893456598155, 7192.604406757679, 7197.820054498679, 7432.145303290083, 3732.4774531565604, 3885.3977633466857, 3894.571597124314, 3897.434871943609, 3916.236333914859, 2922.064939219472, 3029.8485075746125, 3043.9847800760854, 3044.9238769030953, 3048.603681521388, 516.839779668304, 522.4592546714133, 523.0, 530.6842428754885, 541.0909671751417, 480.62991496547465, 589.9970500147472, 591.3554225893711, 619.4641634985705, 647.7409036385484, 8047.579778594074, 8163.959180204061, 8332.541710205876, 8429.157084291523, 8511.063782983867, 483.43196743825865, 493.49416847730646, 555.5722093987607, 592.2034863109197, 605.1860247966478, 3908.804559772057, 4108.116754897652, 4263.317869140985, 4293.0, 4303.935440968388, 96032.51983740176, 97839.02160978441, 98287.50856245673, 98991.50504247432, 99205.50397248112, 85174.57412712897, 89714.8513267605, 90621.54689226512, 91171.0, 92303.0, 72351.0, 72525.0, 74469.62765186248, 74684.25315746773, 74770.25229747742, 7458.403327733877, 7953.5227886327, 7964.681412743425, 7990.8002299940645, 8191.303739181998, 40525.39211911883, 41031.17937641171, 41391.37912931369, 41487.377689335284, 42841.357379638706, 55436.445635543125, 58831.11753323618, 61362.54549817957, 63866.0, 64291.357086430406, 11266.211365204357, 11270.830937536108, 11304.321740695585, 11950.282983021047, 12301.753964920472, 13003.674908126994, 13393.866061339262, 13567.52513662017, 13956.651083722989, 14410.495632652806, 12131.090168237593, 12271.509139634672, 12347.62957111288, 12625.87374126247, 12640.431180596712, 10699.411532365795, 11683.0, 11824.46789894474, 12449.502019919102, 12869.356532173166, 11512.82730759056, 12412.0, 12739.490420383081, 12741.17182383142, 13432.664183395493, 9947.651832185838, 10003.34978226413, 10551.366917984946, 11188.444510400499, 11337.433128343715, 9800.558974846006, 10126.645567405105, 10168.237382196217, 10170.440625765357, 10267.178625710074], "value": 6653.230024230518, "unit": "score"}], "name": "dromaeo_css", "value": 6356.7698768661585, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 114.0, 114.0, 114.0, 115.0, 114.0, 113.0, 115.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 126.0, 124.0, 164.0, 129.0, 127.0, 123.0, 123.0, 163.0, 124.0], "value": 136.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 162.0, 162.0, 161.0, 162.0, 162.0, 161.0, 164.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 118.0, 77.0, 80.0, 77.0, 78.0, 105.0, 77.0], "value": 84.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 121.0, 85.0, 85.0, 85.0, 105.0, 85.0, 84.0, 111.0], "value": 93.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 119.0, 119.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 148.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 94.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 66.0, 62.0, 63.0, 63.0, 64.0, 64.0], "value": 63.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 74.0, 66.0, 66.0, 66.0, 66.0, 66.0], "value": 66.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 82.0, 82.0, 84.0, 83.0, 82.0, 83.0, 82.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 134.0, 133.0, 140.0, 134.0, 133.0, 133.0, 133.0, 165.0, 145.0], "value": 138.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 177.0, 171.0, 176.0, 171.0, 172.0, 173.0, 174.0, 173.0, 170.0], "value": 173.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 72.0, 73.0, 74.0, 70.0, 74.0, 69.0, 69.0, 68.0], "value": 70.9, "unit": "score"}], "name": "kraken", "value": 1544.6000000000001, "alertThreshold": 2.0}]} 05:30:54 INFO - Return code: 0 05:30:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:30:54 INFO - # TBPL SUCCESS # 05:30:54 INFO - Running post-action listener: _resource_record_post_action 05:30:54 INFO - [mozharness: 2016-09-23 12:30:54.990271Z] Finished run-tests step (success) 05:30:54 INFO - Running post-run listener: _resource_record_post_run 05:30:55 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 389152768; Read time: 8; Write time: 340824 05:30:55 INFO - TinderboxPrint: CPU usage
13.1% 05:30:55 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 05:30:55 INFO - TinderboxPrint: I/O write bytes / time
389,152,768 / 340,824 05:30:55 INFO - TinderboxPrint: CPU idle
8,348.9 (86.9%) 05:30:55 INFO - TinderboxPrint: CPU user
1,206.8 (12.6%) 05:30:55 INFO - TinderboxPrint: Swap in / out
0 / 0 05:30:55 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99737600; Read time: 0; Write time: 114412 05:30:55 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 289415168; Read time: 0; Write time: 226412 05:30:55 INFO - Running post-run listener: _upload_blobber_files 05:30:55 INFO - Blob upload gear active. 05:30:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:30:55 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 05:30:55 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'] 05:30:55 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 05:30:56 INFO - (blobuploader) - INFO - Open directory for files ... 05:30:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:30:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:30:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:30:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:30:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:30:56 INFO - (blobuploader) - INFO - Done attempting. 05:30:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:30:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:30:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:31:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:00 INFO - (blobuploader) - INFO - Done attempting. 05:31:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:31:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:31:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:01 INFO - (blobuploader) - INFO - Done attempting. 05:31:01 INFO - (blobuploader) - INFO - Iteration through files over. 05:31:01 INFO - Return code: 0 05:31:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:31:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:31:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/36bc5730d82f4aca2fddc19220caee17e75baaff40c31e51a9749a154627c695ef78677e35bbb163757449383da5083b0a9bb86a2833f898d1df23df8541cd98", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8ff5137b27211b1457dbc5b0d183824f9239f626a661956f73e2a45ef677466314f38d39c6197b9a9ad9c38563624cdacc09b58d3b0b73775509092bccc43235", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/165a46c6f2d0e14004528ab858ca43b2178969ace03a7893fbed0b08a9a46d8a2cac51adee2a0fd5909e50d5199d77f79e433a14654af03edd954fe6a3a3bea8"} 05:31:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:31:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:31:01 INFO - Contents: 05:31:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/36bc5730d82f4aca2fddc19220caee17e75baaff40c31e51a9749a154627c695ef78677e35bbb163757449383da5083b0a9bb86a2833f898d1df23df8541cd98", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8ff5137b27211b1457dbc5b0d183824f9239f626a661956f73e2a45ef677466314f38d39c6197b9a9ad9c38563624cdacc09b58d3b0b73775509092bccc43235", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/165a46c6f2d0e14004528ab858ca43b2178969ace03a7893fbed0b08a9a46d8a2cac51adee2a0fd5909e50d5199d77f79e433a14654af03edd954fe6a3a3bea8"} 05:31:01 INFO - Running post-run listener: copy_logs_to_upload_dir 05:31:01 INFO - Copying logs to upload dir... 05:31:01 INFO - mkdir: /builds/slave/test/build/upload/logs 05:31:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.306887 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-09-23 05:31:00.852530) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 05:31:00.856145) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1474631992.119591-886655371 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/36bc5730d82f4aca2fddc19220caee17e75baaff40c31e51a9749a154627c695ef78677e35bbb163757449383da5083b0a9bb86a2833f898d1df23df8541cd98", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8ff5137b27211b1457dbc5b0d183824f9239f626a661956f73e2a45ef677466314f38d39c6197b9a9ad9c38563624cdacc09b58d3b0b73775509092bccc43235", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/165a46c6f2d0e14004528ab858ca43b2178969ace03a7893fbed0b08a9a46d8a2cac51adee2a0fd5909e50d5199d77f79e433a14654af03edd954fe6a3a3bea8"} build_url:https://queue.taskcluster.net/v1/task/Zbvo8lYaSHmrdXd3kH0TFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011376 build_url: 'https://queue.taskcluster.net/v1/task/Zbvo8lYaSHmrdXd3kH0TFg/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/36bc5730d82f4aca2fddc19220caee17e75baaff40c31e51a9749a154627c695ef78677e35bbb163757449383da5083b0a9bb86a2833f898d1df23df8541cd98", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8ff5137b27211b1457dbc5b0d183824f9239f626a661956f73e2a45ef677466314f38d39c6197b9a9ad9c38563624cdacc09b58d3b0b73775509092bccc43235", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/165a46c6f2d0e14004528ab858ca43b2178969ace03a7893fbed0b08a9a46d8a2cac51adee2a0fd5909e50d5199d77f79e433a14654af03edd954fe6a3a3bea8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 05:31:00.881407) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 05:31:00.881741) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1474631992.119591-886655371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004415 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 05:31:00.965489) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 05:31:00.965821) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 05:31:00.966129) ========= ========= Total master_lag: 0.17 =========