builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1475005908.27 results: success (0) buildid: 20160927093046 builduid: adc29abbf3454bf588fd2342cc44952b revision: b0d4f06aabd64fe182c1f145d70c90681d91028f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 12:51:48.275097) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 12:51:48.275629) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 12:51:48.275964) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 12:51:48.290944) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 12:51:48.291325) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1475005907.748847-207031740 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-27 12:51:48-- 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% 50.6M=0s 2016-09-27 12:51:48 (50.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.410255 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 12:51:48.715683) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 12:51:48.716028) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1475005907.748847-207031740 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018698 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 12:51:48.765644) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 12:51:48.766023) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b0d4f06aabd64fe182c1f145d70c90681d91028f --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 b0d4f06aabd64fe182c1f145d70c90681d91028f --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=edae0fb5fee9fb758e8af6d3000002a4-1475005907.748847-207031740 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-27 12:51:48,926 truncating revision to first 12 chars 2016-09-27 12:51:48,926 Setting DEBUG logging. 2016-09-27 12:51:48,926 attempt 1/10 2016-09-27 12:51:48,926 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b0d4f06aabd6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-27 12:51:49,610 unpacking tar archive at: fx-team-b0d4f06aabd6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.051650 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 12:51:49.831114) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 12:51:49.831438) ========= script_repo_revision: b0d4f06aabd64fe182c1f145d70c90681d91028f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 12:51:49.831886) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 12:51:49.832184) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 12:51:49.841985) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-09-27 12:51:49.842287) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=edae0fb5fee9fb758e8af6d3000002a4-1475005907.748847-207031740 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:51:50 INFO - MultiFileLogger online at 20160927 12:51:50 in /builds/slave/test 12:51:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 12:51:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:51:50 INFO - {'append_to_log': False, 12:51:50 INFO - 'base_work_dir': '/builds/slave/test', 12:51:50 INFO - 'blob_upload_branch': 'Fx-Team', 12:51:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:51:50 INFO - 'branch': 'Fx-Team', 12:51:50 INFO - 'buildbot_json_path': 'buildprops.json', 12:51:50 INFO - 'config_files': ('talos/linux_config.py',), 12:51:50 INFO - 'default_actions': ('clobber', 12:51:50 INFO - 'read-buildbot-config', 12:51:50 INFO - 'download-and-extract', 12:51:50 INFO - 'populate-webroot', 12:51:50 INFO - 'create-virtualenv', 12:51:50 INFO - 'install', 12:51:50 INFO - 'run-tests'), 12:51:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:51:50 INFO - 'download_minidump_stackwalk': True, 12:51:50 INFO - 'download_symbols': 'ondemand', 12:51:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:51:50 INFO - 'tooltool.py': '/tools/tooltool.py', 12:51:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:51:50 INFO - '/tools/misc-python/virtualenv.py')}, 12:51:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:51:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:51:50 INFO - 'installer_path': 'installer.exe', 12:51:50 INFO - 'log_level': 'info', 12:51:50 INFO - 'log_name': 'talos', 12:51:50 INFO - 'log_to_console': True, 12:51:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:51:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:51:50 INFO - 'opt_config_files': (), 12:51:50 INFO - 'pip_index': False, 12:51:50 INFO - 'sps_profile': False, 12:51:50 INFO - 'sps_profile_interval': 0, 12:51:50 INFO - 'suite': 'dromaeojs', 12:51:50 INFO - 'system_bits': '32', 12:51:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:51:50 INFO - 'title': 'talos-linux64-ix-033', 12:51:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:51:50 INFO - 'use_talos_json': True, 12:51:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:51:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:51:50 INFO - 'work_dir': 'build'} 12:51:50 INFO - [mozharness: 2016-09-27 19:51:50.105676Z] Running clobber step. 12:51:50 INFO - Running pre-action listener: _resource_record_pre_action 12:51:50 INFO - Running main action method: clobber 12:51:50 INFO - rmtree: /builds/slave/test/build 12:51:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:51:51 INFO - Running post-action listener: _resource_record_post_action 12:51:51 INFO - [mozharness: 2016-09-27 19:51:51.070298Z] Finished clobber step (success) 12:51:51 INFO - [mozharness: 2016-09-27 19:51:51.070397Z] Running read-buildbot-config step. 12:51:51 INFO - Running pre-action listener: _resource_record_pre_action 12:51:51 INFO - Running main action method: read_buildbot_config 12:51:51 INFO - Using buildbot properties: 12:51:51 INFO - { 12:51:51 INFO - "project": "", 12:51:51 INFO - "product": "firefox", 12:51:51 INFO - "script_repo_revision": "production", 12:51:51 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:51:51 INFO - "repository": "", 12:51:51 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 12:51:51 INFO - "buildid": "20160927093046", 12:51:51 INFO - "pgo_build": "True", 12:51:51 INFO - "basedir": "/builds/slave/test", 12:51:51 INFO - "buildnumber": 1084, 12:51:51 INFO - "slavename": "talos-linux64-ix-033", 12:51:51 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:51:51 INFO - "platform": "ubuntu64_hw", 12:51:51 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 12:51:51 INFO - "branch": "fx-team", 12:51:51 INFO - "repo_path": "integration/fx-team", 12:51:51 INFO - "revision": "b0d4f06aabd64fe182c1f145d70c90681d91028f", 12:51:51 INFO - "stage_platform": "linux64-pgo", 12:51:51 INFO - "builduid": "adc29abbf3454bf588fd2342cc44952b", 12:51:51 INFO - "slavebuilddir": "test" 12:51:51 INFO - } 12:51:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/di3Cbpa_Q76c--xlwxsgfA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 12:51:51 INFO - Running post-action listener: _resource_record_post_action 12:51:51 INFO - [mozharness: 2016-09-27 19:51:51.072796Z] Finished read-buildbot-config step (success) 12:51:51 INFO - [mozharness: 2016-09-27 19:51:51.072884Z] Running download-and-extract step. 12:51:51 INFO - Running pre-action listener: _resource_record_pre_action 12:51:51 INFO - Running main action method: download_and_extract 12:51:51 INFO - mkdir: /builds/slave/test/build/tests 12:51:51 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')]} 12:51:51 INFO - trying https://queue.taskcluster.net/v1/task/di3Cbpa_Q76c--xlwxsgfA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:51:51 INFO - Downloading https://queue.taskcluster.net/v1/task/di3Cbpa_Q76c--xlwxsgfA/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 12:51:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/di3Cbpa_Q76c--xlwxsgfA/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 12:51:51 INFO - Downloaded 1361 bytes. 12:51:51 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:51:51 INFO - Using the following test package requirements: 12:51:51 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:51:51 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:51 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:51:51 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:51 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:51:51 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:51 INFO - u'jsshell-linux-x86_64.zip'], 12:51:51 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:51 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:51:51 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:51:51 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:51 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:51:51 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:51 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:51:51 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:51 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:51:51 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:51 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:51:51 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:51:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/di3Cbpa_Q76c--xlwxsgfA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:51:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/di3Cbpa_Q76c--xlwxsgfA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:51:51 INFO - Fetch https://queue.taskcluster.net/v1/task/di3Cbpa_Q76c--xlwxsgfA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:51:52 INFO - Expected file size: 21983927 12:51:56 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 12:51:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/di3Cbpa_Q76c--xlwxsgfA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:51:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/di3Cbpa_Q76c--xlwxsgfA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:51:56 INFO - Fetch https://queue.taskcluster.net/v1/task/di3Cbpa_Q76c--xlwxsgfA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:51:57 INFO - Expected file size: 21983927 12:52:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/di3Cbpa_Q76c--xlwxsgfA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 12:52:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/di3Cbpa_Q76c--xlwxsgfA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:52:01 INFO - Fetch https://queue.taskcluster.net/v1/task/di3Cbpa_Q76c--xlwxsgfA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 12:52:02 INFO - Expected file size: 14414062 12:52:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:02 INFO - trying https://queue.taskcluster.net/v1/task/di3Cbpa_Q76c--xlwxsgfA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:52:02 INFO - Downloading https://queue.taskcluster.net/v1/task/di3Cbpa_Q76c--xlwxsgfA/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 12:52:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/di3Cbpa_Q76c--xlwxsgfA/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 12:52:04 INFO - Downloaded 59708564 bytes. 12:52:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/di3Cbpa_Q76c--xlwxsgfA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:52:04 INFO - mkdir: /builds/slave/test/properties 12:52:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:52:04 INFO - Writing to file /builds/slave/test/properties/build_url 12:52:04 INFO - Contents: 12:52:04 INFO - build_url:https://queue.taskcluster.net/v1/task/di3Cbpa_Q76c--xlwxsgfA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:52:04 INFO - Running post-action listener: _resource_record_post_action 12:52:04 INFO - Running post-action listener: set_extra_try_arguments 12:52:04 INFO - [mozharness: 2016-09-27 19:52:04.731831Z] Finished download-and-extract step (success) 12:52:04 INFO - [mozharness: 2016-09-27 19:52:04.732058Z] Running populate-webroot step. 12:52:04 INFO - Running pre-action listener: _resource_record_pre_action 12:52:04 INFO - Running main action method: populate_webroot 12:52:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:52:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:52:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:52:04 INFO - '--tppagecycles', 12:52:04 INFO - '7'], 12:52:04 INFO - 'tests': ['tsvgm']}}, 12:52:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:52:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:52:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:52:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:52:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:52:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:52:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:04 INFO - 'talos_options': ['--disable-e10s'], 12:52:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:52:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:52:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:04 INFO - 'talos_options': ['--disable-e10s'], 12:52:04 INFO - 'tests': ['damp', 'tps']}, 12:52:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:04 INFO - 'tests': ['damp', 'tps']}, 12:52:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:52:04 INFO - 'tests': ['dromaeo_dom']}, 12:52:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:52:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:52:04 INFO - 'tests': ['basic_compositor_video']}, 12:52:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:52:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:52:04 INFO - 'tests': ['a11yr', 12:52:04 INFO - 'ts_paint', 12:52:04 INFO - 'tpaint', 12:52:04 INFO - 'sessionrestore', 12:52:04 INFO - 'sessionrestore_no_auto_restore', 12:52:04 INFO - 'tabpaint']}, 12:52:04 INFO - 'other-e10s': {'tests': ['a11yr', 12:52:04 INFO - 'ts_paint', 12:52:04 INFO - 'tpaint', 12:52:04 INFO - 'sessionrestore', 12:52:04 INFO - 'sessionrestore_no_auto_restore', 12:52:04 INFO - 'tabpaint']}, 12:52:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:52:04 INFO - 'ts_paint', 12:52:04 INFO - 'tpaint', 12:52:04 INFO - 'sessionrestore', 12:52:04 INFO - 'sessionrestore_no_auto_restore', 12:52:04 INFO - 'tabpaint']}, 12:52:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:52:04 INFO - 'ts_paint', 12:52:04 INFO - 'tpaint', 12:52:04 INFO - 'sessionrestore', 12:52:04 INFO - 'sessionrestore_no_auto_restore', 12:52:04 INFO - 'tabpaint']}, 12:52:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:52:04 INFO - 'tests': ['a11yr', 12:52:04 INFO - 'ts_paint', 12:52:04 INFO - 'tpaint', 12:52:04 INFO - 'sessionrestore', 12:52:04 INFO - 'sessionrestore_no_auto_restore', 12:52:04 INFO - 'tabpaint']}, 12:52:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:52:04 INFO - 'tests': ['a11yr', 12:52:04 INFO - 'ts_paint', 12:52:04 INFO - 'tpaint', 12:52:04 INFO - 'sessionrestore', 12:52:04 INFO - 'sessionrestore_no_auto_restore', 12:52:04 INFO - 'tabpaint']}, 12:52:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:52:04 INFO - 'tests': ['tsvgx', 12:52:04 INFO - 'tsvgr_opacity', 12:52:04 INFO - 'tart', 12:52:04 INFO - 'tscrollx', 12:52:04 INFO - 'cart']}, 12:52:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:52:04 INFO - 'tsvgr_opacity', 12:52:04 INFO - 'tart', 12:52:04 INFO - 'tscrollx', 12:52:04 INFO - 'cart']}, 12:52:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:04 INFO - 'talos_options': ['--disable-e10s'], 12:52:04 INFO - 'tests': ['tp5o']}, 12:52:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:04 INFO - 'tests': ['tp5o']}, 12:52:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:04 INFO - 'talos_options': ['--disable-e10s', 12:52:04 INFO - '--xperf_path', 12:52:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:52:04 INFO - 'tests': ['tp5n']}, 12:52:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:04 INFO - 'talos_options': ['--xperf_path', 12:52:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:52:04 INFO - 'tests': ['tp5n']}}, 12:52:04 INFO - 'talos.zip': {'path': '', 12:52:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:52:04 INFO - Running post-action listener: _resource_record_post_action 12:52:04 INFO - [mozharness: 2016-09-27 19:52:04.752601Z] Finished populate-webroot step (success) 12:52:04 INFO - [mozharness: 2016-09-27 19:52:04.752705Z] Running create-virtualenv step. 12:52:04 INFO - Running pre-action listener: _resource_record_pre_action 12:52:04 INFO - Running main action method: create_virtualenv 12:52:04 INFO - Creating virtualenv /builds/slave/test/build/venv 12:52:04 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 12:52:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:52:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:52:04 INFO - Using real prefix '/usr' 12:52:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:52:05 INFO - Installing distribute.............................................................................................................................................................................................done. 12:52:07 INFO - Installing pip.................done. 12:52:07 INFO - Return code: 0 12:52:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:52:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:52:07 INFO - Reading from file tmpfile_stdout 12:52:07 INFO - Output received: 12:52:07 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 12:52:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:52:07 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')]} 12:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:07 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')]} 12:52:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:07 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 0x7ffba0747f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b1790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ae930>, '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 0x11af830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11afcc0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1475005907.748847-207031740', '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 12:52:07 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 12:52:07 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 12:52:07 INFO - Using env: {'DISPLAY': ':0', 12:52:07 INFO - 'HOME': '/home/cltbld', 12:52:07 INFO - 'LANG': 'en_US.UTF-8', 12:52:07 INFO - 'LANGUAGE': 'en_US:en', 12:52:07 INFO - 'LOGNAME': 'cltbld', 12:52:07 INFO - 'MAIL': '/var/mail/cltbld', 12:52:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:07 INFO - 'MOZ_NO_REMOTE': '1', 12:52:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:07 INFO - 'NO_EM_RESTART': '1', 12:52:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:07 INFO - 'PWD': '/builds/slave/test', 12:52:07 INFO - 'SHELL': '/bin/bash', 12:52:07 INFO - 'SHLVL': '1', 12:52:07 INFO - 'TERM': 'linux', 12:52:07 INFO - 'TMOUT': '86400', 12:52:07 INFO - 'USER': 'cltbld', 12:52:07 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1475005907.748847-207031740', 12:52:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:07 INFO - '_': '/tools/buildbot/bin/python'} 12:52:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:07 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 12:52:07 INFO - Cleaning up... 12:52:07 INFO - Return code: 0 12:52:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:52:07 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')]} 12:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:07 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')]} 12:52:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:07 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 0x7ffba0747f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b1790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ae930>, '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 0x11af830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11afcc0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1475005907.748847-207031740', '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 12:52:07 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 12:52:07 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 12:52:07 INFO - Using env: {'DISPLAY': ':0', 12:52:07 INFO - 'HOME': '/home/cltbld', 12:52:07 INFO - 'LANG': 'en_US.UTF-8', 12:52:07 INFO - 'LANGUAGE': 'en_US:en', 12:52:07 INFO - 'LOGNAME': 'cltbld', 12:52:07 INFO - 'MAIL': '/var/mail/cltbld', 12:52:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:07 INFO - 'MOZ_NO_REMOTE': '1', 12:52:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:07 INFO - 'NO_EM_RESTART': '1', 12:52:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:07 INFO - 'PWD': '/builds/slave/test', 12:52:07 INFO - 'SHELL': '/bin/bash', 12:52:07 INFO - 'SHLVL': '1', 12:52:07 INFO - 'TERM': 'linux', 12:52:07 INFO - 'TMOUT': '86400', 12:52:07 INFO - 'USER': 'cltbld', 12:52:07 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1475005907.748847-207031740', 12:52:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:07 INFO - '_': '/tools/buildbot/bin/python'} 12:52:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:07 INFO - Downloading/unpacking psutil>=3.1.1 12:52:07 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 12:52:07 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 12:52:07 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 12:52:07 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 12:52:07 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 12:52:07 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 12:52:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:52:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:52:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:52:09 INFO - Installing collected packages: psutil 12:52:09 INFO - Running setup.py install for psutil 12:52:10 INFO - building 'psutil._psutil_linux' extension 12:52:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:52:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:52:10 INFO - building 'psutil._psutil_posix' extension 12:52:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:52:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:52:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:52:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:52:10 INFO - Successfully installed psutil 12:52:10 INFO - Cleaning up... 12:52:10 INFO - Return code: 0 12:52:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:52:10 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')]} 12:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:10 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')]} 12:52:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x7ffba0747f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b1790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ae930>, '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 0x11af830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11afcc0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1475005907.748847-207031740', '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 12:52:10 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 12:52:10 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 12:52:10 INFO - Using env: {'DISPLAY': ':0', 12:52:10 INFO - 'HOME': '/home/cltbld', 12:52:10 INFO - 'LANG': 'en_US.UTF-8', 12:52:10 INFO - 'LANGUAGE': 'en_US:en', 12:52:10 INFO - 'LOGNAME': 'cltbld', 12:52:10 INFO - 'MAIL': '/var/mail/cltbld', 12:52:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:10 INFO - 'MOZ_NO_REMOTE': '1', 12:52:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:10 INFO - 'NO_EM_RESTART': '1', 12:52:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:10 INFO - 'PWD': '/builds/slave/test', 12:52:10 INFO - 'SHELL': '/bin/bash', 12:52:10 INFO - 'SHLVL': '1', 12:52:10 INFO - 'TERM': 'linux', 12:52:10 INFO - 'TMOUT': '86400', 12:52:10 INFO - 'USER': 'cltbld', 12:52:10 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1475005907.748847-207031740', 12:52:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:10 INFO - '_': '/tools/buildbot/bin/python'} 12:52:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:52:10 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 12:52:10 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 12:52:10 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 12:52:10 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 12:52:10 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 12:52:10 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 12:52:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:52:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:52:12 INFO - Installing collected packages: mozsystemmonitor 12:52:12 INFO - Running setup.py install for mozsystemmonitor 12:52:12 INFO - Successfully installed mozsystemmonitor 12:52:12 INFO - Cleaning up... 12:52:12 INFO - Return code: 0 12:52:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:52:12 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')]} 12:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:12 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')]} 12:52:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x7ffba0747f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b1790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ae930>, '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 0x11af830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11afcc0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1475005907.748847-207031740', '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 12:52:12 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 12:52:12 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 12:52:12 INFO - Using env: {'DISPLAY': ':0', 12:52:12 INFO - 'HOME': '/home/cltbld', 12:52:12 INFO - 'LANG': 'en_US.UTF-8', 12:52:12 INFO - 'LANGUAGE': 'en_US:en', 12:52:12 INFO - 'LOGNAME': 'cltbld', 12:52:12 INFO - 'MAIL': '/var/mail/cltbld', 12:52:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:12 INFO - 'MOZ_NO_REMOTE': '1', 12:52:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:12 INFO - 'NO_EM_RESTART': '1', 12:52:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:12 INFO - 'PWD': '/builds/slave/test', 12:52:12 INFO - 'SHELL': '/bin/bash', 12:52:12 INFO - 'SHLVL': '1', 12:52:12 INFO - 'TERM': 'linux', 12:52:12 INFO - 'TMOUT': '86400', 12:52:12 INFO - 'USER': 'cltbld', 12:52:12 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1475005907.748847-207031740', 12:52:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:12 INFO - '_': '/tools/buildbot/bin/python'} 12:52:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:12 INFO - Downloading/unpacking jsonschema==2.5.1 12:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:12 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 12:52:12 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 12:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:52:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:14 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 12:52:14 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 12:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:15 INFO - Downloading functools32-3.2.3-2.tar.gz 12:52:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:52:15 INFO - warning: no files found matching '*.txt' 12:52:15 INFO - no previously-included directories found matching 'build' 12:52:15 INFO - no previously-included directories found matching 'dist' 12:52:15 INFO - no previously-included directories found matching '.git*' 12:52:15 INFO - Installing collected packages: jsonschema, functools32 12:52:15 INFO - Running setup.py install for functools32 12:52:15 INFO - warning: no files found matching '*.txt' 12:52:15 INFO - no previously-included directories found matching 'build' 12:52:15 INFO - no previously-included directories found matching 'dist' 12:52:15 INFO - no previously-included directories found matching '.git*' 12:52:15 INFO - Successfully installed jsonschema functools32 12:52:15 INFO - Cleaning up... 12:52:15 INFO - Return code: 0 12:52:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:52:15 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')]} 12:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:15 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')]} 12:52:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:15 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 0x7ffba0747f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b1790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ae930>, '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 0x11af830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11afcc0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1475005907.748847-207031740', '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 12:52:15 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 12:52:15 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 12:52:15 INFO - Using env: {'DISPLAY': ':0', 12:52:15 INFO - 'HOME': '/home/cltbld', 12:52:15 INFO - 'LANG': 'en_US.UTF-8', 12:52:15 INFO - 'LANGUAGE': 'en_US:en', 12:52:15 INFO - 'LOGNAME': 'cltbld', 12:52:15 INFO - 'MAIL': '/var/mail/cltbld', 12:52:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:15 INFO - 'MOZ_NO_REMOTE': '1', 12:52:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:15 INFO - 'NO_EM_RESTART': '1', 12:52:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:15 INFO - 'PWD': '/builds/slave/test', 12:52:15 INFO - 'SHELL': '/bin/bash', 12:52:15 INFO - 'SHLVL': '1', 12:52:15 INFO - 'TERM': 'linux', 12:52:15 INFO - 'TMOUT': '86400', 12:52:15 INFO - 'USER': 'cltbld', 12:52:15 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1475005907.748847-207031740', 12:52:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:15 INFO - '_': '/tools/buildbot/bin/python'} 12:52:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:52:15 INFO - Cleaning up... 12:52:15 INFO - Return code: 0 12:52:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:52:15 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')]} 12:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:15 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')]} 12:52:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:15 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 0x7ffba0747f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b1790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ae930>, '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 0x11af830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11afcc0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1475005907.748847-207031740', '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 12:52:15 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 12:52:15 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 12:52:15 INFO - Using env: {'DISPLAY': ':0', 12:52:15 INFO - 'HOME': '/home/cltbld', 12:52:15 INFO - 'LANG': 'en_US.UTF-8', 12:52:15 INFO - 'LANGUAGE': 'en_US:en', 12:52:15 INFO - 'LOGNAME': 'cltbld', 12:52:15 INFO - 'MAIL': '/var/mail/cltbld', 12:52:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:15 INFO - 'MOZ_NO_REMOTE': '1', 12:52:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:15 INFO - 'NO_EM_RESTART': '1', 12:52:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:15 INFO - 'PWD': '/builds/slave/test', 12:52:15 INFO - 'SHELL': '/bin/bash', 12:52:15 INFO - 'SHLVL': '1', 12:52:15 INFO - 'TERM': 'linux', 12:52:15 INFO - 'TMOUT': '86400', 12:52:15 INFO - 'USER': 'cltbld', 12:52:15 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1475005907.748847-207031740', 12:52:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:15 INFO - '_': '/tools/buildbot/bin/python'} 12:52:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:15 INFO - Downloading/unpacking blobuploader==1.2.4 12:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:15 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 12:52:15 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 12:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:17 INFO - Downloading blobuploader-1.2.4.tar.gz 12:52:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:52:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:52:17 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 12:52:17 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 12:52:17 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 12:52:17 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 12:52:17 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 12:52:17 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 12:52:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:52:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:52:18 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 12:52:18 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 12:52:18 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 12:52:18 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 12:52:18 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 12:52:18 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 12:52:18 INFO - Downloading docopt-0.6.1.tar.gz 12:52:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:52:18 INFO - Installing collected packages: blobuploader, requests, docopt 12:52:18 INFO - Running setup.py install for blobuploader 12:52:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:52:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:52:18 INFO - Running setup.py install for requests 12:52:18 INFO - Running setup.py install for docopt 12:52:19 INFO - Successfully installed blobuploader requests docopt 12:52:19 INFO - Cleaning up... 12:52:19 INFO - Return code: 0 12:52:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:52:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:19 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 0x7ffba0747f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b1790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ae930>, '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 0x11af830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11afcc0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1475005907.748847-207031740', '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 12:52:19 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 12:52:19 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 12:52:19 INFO - Using env: {'DISPLAY': ':0', 12:52:19 INFO - 'HOME': '/home/cltbld', 12:52:19 INFO - 'LANG': 'en_US.UTF-8', 12:52:19 INFO - 'LANGUAGE': 'en_US:en', 12:52:19 INFO - 'LOGNAME': 'cltbld', 12:52:19 INFO - 'MAIL': '/var/mail/cltbld', 12:52:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:19 INFO - 'MOZ_NO_REMOTE': '1', 12:52:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:19 INFO - 'NO_EM_RESTART': '1', 12:52:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:19 INFO - 'PWD': '/builds/slave/test', 12:52:19 INFO - 'SHELL': '/bin/bash', 12:52:19 INFO - 'SHLVL': '1', 12:52:19 INFO - 'TERM': 'linux', 12:52:19 INFO - 'TMOUT': '86400', 12:52:19 INFO - 'USER': 'cltbld', 12:52:19 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1475005907.748847-207031740', 12:52:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:19 INFO - '_': '/tools/buildbot/bin/python'} 12:52:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:52:19 INFO - Running setup.py (path:/tmp/pip-LPrPJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:52:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:52:19 INFO - Running setup.py (path:/tmp/pip-ML1gCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:52:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:52:19 INFO - Running setup.py (path:/tmp/pip-2JWMAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:52:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:52:19 INFO - Running setup.py (path:/tmp/pip-tW2r5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:52:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:52:19 INFO - Running setup.py (path:/tmp/pip-Fvps0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:52:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:52:19 INFO - Running setup.py (path:/tmp/pip-WyLKW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:52:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:52:19 INFO - Running setup.py (path:/tmp/pip-ttayW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:52:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:52:19 INFO - Running setup.py (path:/tmp/pip-lVupsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:52:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:52:19 INFO - Running setup.py (path:/tmp/pip-PjYbDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:52:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:52:19 INFO - Running setup.py (path:/tmp/pip-hDFQh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:52:20 INFO - Running setup.py (path:/tmp/pip-c2m0VF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:52:20 INFO - Running setup.py (path:/tmp/pip-NDOYI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:52:20 INFO - Running setup.py (path:/tmp/pip-3JsFHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:52:20 INFO - Running setup.py (path:/tmp/pip-bo1L6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:52:20 INFO - Running setup.py (path:/tmp/pip-9G1Dvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:52:20 INFO - Running setup.py (path:/tmp/pip-RoTjw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:52:20 INFO - Running setup.py (path:/tmp/pip-T92EC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:52:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:52:20 INFO - Running setup.py install for manifestparser 12:52:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:52:20 INFO - Running setup.py install for mozcrash 12:52:20 INFO - Running setup.py install for mozdebug 12:52:20 INFO - Running setup.py install for mozdevice 12:52:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:52:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:52:20 INFO - Running setup.py install for mozfile 12:52:21 INFO - Running setup.py install for mozhttpd 12:52:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:52:21 INFO - Running setup.py install for mozinfo 12:52:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:52:21 INFO - Running setup.py install for mozInstall 12:52:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:52:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:52:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:52:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:52:21 INFO - Running setup.py install for mozleak 12:52:21 INFO - Running setup.py install for mozlog 12:52:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:52:21 INFO - Running setup.py install for moznetwork 12:52:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:52:21 INFO - Running setup.py install for mozprocess 12:52:21 INFO - Running setup.py install for mozprofile 12:52:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:52:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:52:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:52:21 INFO - Running setup.py install for mozrunner 12:52:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:52:21 INFO - Running setup.py install for mozscreenshot 12:52:22 INFO - Running setup.py install for moztest 12:52:22 INFO - Running setup.py install for mozversion 12:52:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:52:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:52:22 INFO - Cleaning up... 12:52:22 INFO - Return code: 0 12:52:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:22 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 0x7ffba0747f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b1790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ae930>, '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 0x11af830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11afcc0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1475005907.748847-207031740', '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 12:52:22 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 12:52:22 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 12:52:22 INFO - Using env: {'DISPLAY': ':0', 12:52:22 INFO - 'HOME': '/home/cltbld', 12:52:22 INFO - 'LANG': 'en_US.UTF-8', 12:52:22 INFO - 'LANGUAGE': 'en_US:en', 12:52:22 INFO - 'LOGNAME': 'cltbld', 12:52:22 INFO - 'MAIL': '/var/mail/cltbld', 12:52:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:22 INFO - 'MOZ_NO_REMOTE': '1', 12:52:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:22 INFO - 'NO_EM_RESTART': '1', 12:52:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:22 INFO - 'PWD': '/builds/slave/test', 12:52:22 INFO - 'SHELL': '/bin/bash', 12:52:22 INFO - 'SHLVL': '1', 12:52:22 INFO - 'TERM': 'linux', 12:52:22 INFO - 'TMOUT': '86400', 12:52:22 INFO - 'USER': 'cltbld', 12:52:22 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1475005907.748847-207031740', 12:52:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:22 INFO - '_': '/tools/buildbot/bin/python'} 12:52:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:52:22 INFO - Running setup.py (path:/tmp/pip-RNhPEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:52:22 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)) 12:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:52:22 INFO - Running setup.py (path:/tmp/pip-_d0HgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:52:22 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)) 12:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:52:22 INFO - Running setup.py (path:/tmp/pip-ll9aN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:52:22 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)) 12:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:52:22 INFO - Running setup.py (path:/tmp/pip-PANLfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:52:22 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)) 12:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:52:22 INFO - Running setup.py (path:/tmp/pip-cPjzxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:52:22 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)) 12:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:52:22 INFO - Running setup.py (path:/tmp/pip-QB3HJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:52:22 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)) 12:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:52:22 INFO - Running setup.py (path:/tmp/pip-Ol_OYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:52:23 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)) 12:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:52:23 INFO - Running setup.py (path:/tmp/pip-2b2Au6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:52:23 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)) 12:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:52:23 INFO - Running setup.py (path:/tmp/pip-u60SWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:52:23 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)) 12:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:52:23 INFO - Running setup.py (path:/tmp/pip-kpcxLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:52:23 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)) 12:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:52:23 INFO - Running setup.py (path:/tmp/pip-b_iefN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:52:23 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)) 12:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:52:23 INFO - Running setup.py (path:/tmp/pip-Kgrs3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:52:23 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)) 12:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:52:23 INFO - Running setup.py (path:/tmp/pip-26PMfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:52:23 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)) 12:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:52:23 INFO - Running setup.py (path:/tmp/pip-LoqtmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:52:23 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)) 12:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:52:23 INFO - Running setup.py (path:/tmp/pip-fcj8uD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:52:23 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)) 12:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:52:23 INFO - Running setup.py (path:/tmp/pip-W2lHXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:52:23 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)) 12:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:52:23 INFO - Running setup.py (path:/tmp/pip-WPHyLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:52:23 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)) 12:52:23 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)) 12:52:23 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)) 12:52:23 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)) 12:52:23 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)) 12:52:23 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)) 12:52:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:52:23 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 12:52:23 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 12:52:23 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 12:52:23 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 12:52:23 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 12:52:23 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 12:52:25 INFO - Downloading blessings-1.6.tar.gz 12:52:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:52:25 INFO - Installing collected packages: blessings 12:52:25 INFO - Running setup.py install for blessings 12:52:25 INFO - Successfully installed blessings 12:52:25 INFO - Cleaning up... 12:52:25 INFO - Return code: 0 12:52:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:52:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:52:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:52:26 INFO - Reading from file tmpfile_stdout 12:52:26 INFO - Current package versions: 12:52:26 INFO - argparse == 1.2.1 12:52:26 INFO - blessings == 1.6 12:52:26 INFO - blobuploader == 1.2.4 12:52:26 INFO - docopt == 0.6.1 12:52:26 INFO - functools32 == 3.2.3-2 12:52:26 INFO - jsonschema == 2.5.1 12:52:26 INFO - manifestparser == 1.1 12:52:26 INFO - mozInstall == 1.12 12:52:26 INFO - mozcrash == 0.17 12:52:26 INFO - mozdebug == 0.1 12:52:26 INFO - mozdevice == 0.48 12:52:26 INFO - mozfile == 1.2 12:52:26 INFO - mozhttpd == 0.7 12:52:26 INFO - mozinfo == 0.9 12:52:26 INFO - mozleak == 0.1 12:52:26 INFO - mozlog == 3.4 12:52:26 INFO - moznetwork == 0.27 12:52:26 INFO - mozprocess == 0.23 12:52:26 INFO - mozprofile == 0.28 12:52:26 INFO - mozrunner == 6.12 12:52:26 INFO - mozscreenshot == 0.1 12:52:26 INFO - mozsystemmonitor == 0.3 12:52:26 INFO - moztest == 0.7 12:52:26 INFO - mozversion == 1.4 12:52:26 INFO - psutil == 3.1.1 12:52:26 INFO - requests == 1.2.3 12:52:26 INFO - wsgiref == 0.1.2 12:52:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:26 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 0x7ffba0747f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b1790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ae930>, '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 0x11af830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11afcc0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1475005907.748847-207031740', '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 12:52:26 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 12:52:26 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 12:52:26 INFO - Using env: {'DISPLAY': ':0', 12:52:26 INFO - 'HOME': '/home/cltbld', 12:52:26 INFO - 'LANG': 'en_US.UTF-8', 12:52:26 INFO - 'LANGUAGE': 'en_US:en', 12:52:26 INFO - 'LOGNAME': 'cltbld', 12:52:26 INFO - 'MAIL': '/var/mail/cltbld', 12:52:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:26 INFO - 'MOZ_NO_REMOTE': '1', 12:52:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:26 INFO - 'NO_EM_RESTART': '1', 12:52:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:26 INFO - 'PWD': '/builds/slave/test', 12:52:26 INFO - 'SHELL': '/bin/bash', 12:52:26 INFO - 'SHLVL': '1', 12:52:26 INFO - 'TERM': 'linux', 12:52:26 INFO - 'TMOUT': '86400', 12:52:26 INFO - 'USER': 'cltbld', 12:52:26 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1475005907.748847-207031740', 12:52:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:26 INFO - '_': '/tools/buildbot/bin/python'} 12:52:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:26 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)) 12:52:26 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)) 12:52:26 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)) 12:52:26 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)) 12:52:26 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)) 12:52:26 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)) 12:52:26 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)) 12:52:26 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)) 12:52:26 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)) 12:52:26 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)) 12:52:26 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)) 12:52:26 INFO - Cleaning up... 12:52:26 INFO - Return code: 0 12:52:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffba0747f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b1790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ae930>, '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 0x11af830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11afcc0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1475005907.748847-207031740', '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 12:52:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:52:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:52:26 INFO - Using env: {'DISPLAY': ':0', 12:52:26 INFO - 'HOME': '/home/cltbld', 12:52:26 INFO - 'LANG': 'en_US.UTF-8', 12:52:26 INFO - 'LANGUAGE': 'en_US:en', 12:52:26 INFO - 'LOGNAME': 'cltbld', 12:52:26 INFO - 'MAIL': '/var/mail/cltbld', 12:52:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:26 INFO - 'MOZ_NO_REMOTE': '1', 12:52:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:26 INFO - 'NO_EM_RESTART': '1', 12:52:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:26 INFO - 'PWD': '/builds/slave/test', 12:52:26 INFO - 'SHELL': '/bin/bash', 12:52:26 INFO - 'SHLVL': '1', 12:52:26 INFO - 'TERM': 'linux', 12:52:26 INFO - 'TMOUT': '86400', 12:52:26 INFO - 'USER': 'cltbld', 12:52:26 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1475005907.748847-207031740', 12:52:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:26 INFO - '_': '/tools/buildbot/bin/python'} 12:52:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:52:26 INFO - Cleaning up... 12:52:26 INFO - Return code: 0 12:52:26 INFO - Running post-action listener: _resource_record_post_action 12:52:26 INFO - Running post-action listener: _start_resource_monitoring 12:52:26 INFO - Starting resource monitoring. 12:52:26 INFO - [mozharness: 2016-09-27 19:52:26.572398Z] Finished create-virtualenv step (success) 12:52:26 INFO - [mozharness: 2016-09-27 19:52:26.572901Z] Running install step. 12:52:26 INFO - Running pre-action listener: _resource_record_pre_action 12:52:26 INFO - Running main action method: install 12:52:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:52:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:52:26 INFO - Reading from file tmpfile_stdout 12:52:26 INFO - Detecting whether we're running mozinstall >=1.0... 12:52:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:52:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:52:26 INFO - Reading from file tmpfile_stdout 12:52:26 INFO - Output received: 12:52:26 INFO - Usage: mozinstall [options] installer 12:52:26 INFO - Options: 12:52:26 INFO - -h, --help show this help message and exit 12:52:26 INFO - -d DEST, --destination=DEST 12:52:26 INFO - Directory to install application into. [default: 12:52:26 INFO - "/builds/slave/test"] 12:52:26 INFO - --app=APP Application being installed. [default: firefox] 12:52:26 INFO - mkdir: /builds/slave/test/build/application 12:52:26 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'] 12:52:26 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 12:52:43 INFO - Reading from file tmpfile_stdout 12:52:43 INFO - Output received: 12:52:43 INFO - /builds/slave/test/build/application/firefox/firefox 12:52:43 INFO - Running post-action listener: _resource_record_post_action 12:52:43 INFO - [mozharness: 2016-09-27 19:52:43.878530Z] Finished install step (success) 12:52:43 INFO - [mozharness: 2016-09-27 19:52:43.878773Z] Running run-tests step. 12:52:43 INFO - Running pre-action listener: _resource_record_pre_action 12:52:43 INFO - Running main action method: run_tests 12:52:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:52:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:52:43 INFO - Python 2.7.3 12:52:43 INFO - Return code: 0 12:52:43 INFO - grabbing minidump binary from tooltool 12:52:43 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')]} 12:52:43 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 0x11ae930>, '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 0x11af830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11afcc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:52:43 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 12:52:43 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 12:52:43 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 12:52:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:52:43 INFO - Return code: 0 12:52:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:52:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:52:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:52:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:52:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:52:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/di3Cbpa_Q76c--xlwxsgfA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 12:52:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/di3Cbpa_Q76c--xlwxsgfA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 12:52:43 INFO - Using env: {'DISPLAY': ':0', 12:52:43 INFO - 'HOME': '/home/cltbld', 12:52:43 INFO - 'LANG': 'en_US.UTF-8', 12:52:43 INFO - 'LANGUAGE': 'en_US:en', 12:52:43 INFO - 'LOGNAME': 'cltbld', 12:52:43 INFO - 'MAIL': '/var/mail/cltbld', 12:52:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:52:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:52:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:43 INFO - 'MOZ_NO_REMOTE': '1', 12:52:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:52:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:43 INFO - 'NO_EM_RESTART': '1', 12:52:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:43 INFO - 'PWD': '/builds/slave/test', 12:52:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:52:43 INFO - 'SHELL': '/bin/bash', 12:52:43 INFO - 'SHLVL': '1', 12:52:43 INFO - 'TERM': 'linux', 12:52:43 INFO - 'TMOUT': '86400', 12:52:43 INFO - 'USER': 'cltbld', 12:52:43 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1475005907.748847-207031740', 12:52:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:43 INFO - '_': '/tools/buildbot/bin/python'} 12:52:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/di3Cbpa_Q76c--xlwxsgfA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 12:52:44 INFO - mozversion application_buildid: 20160927093046 12:52:44 INFO - mozversion application_changeset: b0d4f06aabd64fe182c1f145d70c90681d91028f 12:52:44 INFO - mozversion application_display_name: Nightly 12:52:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:52:44 INFO - mozversion application_name: Firefox 12:52:44 INFO - mozversion application_remotingname: firefox 12:52:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:52:44 INFO - mozversion application_vendor: Mozilla 12:52:44 INFO - mozversion application_version: 52.0a1 12:52:44 INFO - mozversion platform_buildid: 20160927093046 12:52:44 INFO - mozversion platform_changeset: b0d4f06aabd64fe182c1f145d70c90681d91028f 12:52:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:52:44 INFO - mozversion platform_version: 52.0a1 12:52:44 INFO - using testdate: 1475005964 12:52:44 INFO - actual date: 1475005964 12:52:44 INFO - starting webserver on 'localhost:36997' 12:52:44 INFO - SUITE-START | Running 2 tests 12:52:44 INFO - TEST-START | dromaeo_css 12:52:44 INFO - operating with platform_type : linux_ 12:52:44 INFO - Initialising browser for dromaeo_css test... 12:52:44 INFO - TEST-INFO | started process 19964 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbw3gOn/profile http://localhost:36997/getInfo.html) 12:52:49 INFO - PROCESS | 19964 | __metrics Screen width/height:1600/1200 12:52:49 INFO - PROCESS | 19964 | colorDepth:24 12:52:49 INFO - PROCESS | 19964 | Browser inner width/height: 1024/697 12:52:49 INFO - PROCESS | 19964 | __metrics 12:52:49 INFO - PROCESS | 19964 | 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" 12:52:49 INFO - PROCESS | 19964 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:52:50 INFO - PROCESS | 19964 | console.error: PushService: 12:52:50 INFO - PROCESS | 19964 | stateChangeProcessEnqueue: Error transitioning state 12:52:50 INFO - PROCESS | 19964 | UnknownError 12:52:51 INFO - TEST-INFO | 19964: exit 0 12:52:51 INFO - Browser initialized. 12:52:51 INFO - Running cycle 1/1 for dromaeo_css test... 12:52:51 INFO - TEST-INFO | started process 20048 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbw3gOn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:53:03 INFO - PROCESS | 20048 | RSS: Main: 173924352 12:53:03 INFO - PROCESS | 20048 | 12:53:54 INFO - PROCESS | 20048 | 1475006034529 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] 12:56:04 INFO - PROCESS | 20048 | Cycle 1(1): loaded http://localhost:36997/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36997/tests/dromaeo/cssquery-ext.html) 12:56:05 INFO - PROCESS | 20048 | RSS: Main: 326320128 12:56:05 INFO - PROCESS | 20048 | 12:59:08 INFO - PROCESS | 20048 | Cycle 1(1): loaded http://localhost:36997/tests/dromaeo/cssquery-ext.html (next: http://localhost:36997/tests/dromaeo/cssquery-jquery.html) 12:59:08 INFO - PROCESS | 20048 | RSS: Main: 277651456 12:59:08 INFO - PROCESS | 20048 | 13:02:10 INFO - PROCESS | 20048 | Cycle 1(1): loaded http://localhost:36997/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36997/tests/dromaeo/cssquery-mootools.html) 13:02:11 INFO - PROCESS | 20048 | RSS: Main: 216223744 13:02:11 INFO - PROCESS | 20048 | 13:05:13 INFO - PROCESS | 20048 | Cycle 1(1): loaded http://localhost:36997/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36997/tests/dromaeo/cssquery-prototype.html) 13:05:14 INFO - PROCESS | 20048 | RSS: Main: 260935680 13:05:14 INFO - PROCESS | 20048 | 13:08:16 INFO - PROCESS | 20048 | Cycle 1(1): loaded http://localhost:36997/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36997/tests/dromaeo/cssquery-yui.html) 13:08:17 INFO - PROCESS | 20048 | RSS: Main: 213774336 13:08:17 INFO - PROCESS | 20048 | 13:11:20 INFO - PROCESS | 20048 | Cycle 1(1): loaded http://localhost:36997/tests/dromaeo/cssquery-yui.html (next: http://localhost:36997/tests/dromaeo/cssquery-dojo.html) 13:11:20 INFO - PROCESS | 20048 | RSS: Main: 309784576 13:11:20 INFO - PROCESS | 20048 | 13:11:20 INFO - PROCESS | 20048 | __start_tp_report 13:11:20 INFO - PROCESS | 20048 | _x_x_mozilla_page_load 13:11:20 INFO - PROCESS | 20048 | _x_x_mozilla_page_load_details 13:11:20 INFO - PROCESS | 20048 | |i|pagename|runs| 13:11:20 INFO - PROCESS | 20048 | |0;dojo.html;3021.80358276712;3046.2688954650876;3054.480738274494;3068.0335694256323;3095.6440009398925;5220.347456567929;5278.524932756051;5344.652597581155;5358.196270559418;5389.434109418514;5304.177852432869;5363.034653762321;5384.703841288728;5428.565714742821;5453.754581043852;4802.279658051303;4842.564169224769;4887.7311747853855;4888.706677599355;5014.147594908874;4989.850304490871;5015.623828212881;5033.043721692867;5041.571466425358;5041.924371134418;4811.711297322172;4879.048585525824;4950.257461380804;5003.4746351633285;5014.899702005958;4912.091263116335;4912.287718280829;4916.483769204217;4917.754112294371;4917.950820491785;4852.878678033042;4855.6601037927;4863.19757240055;4875.268709693539;4883.902321953577;5281.12861377876;5282.788688452457;5313.973430132824;5378.085725426687;5443.319585051869;5722.313322401297;5765.798197063083;5776.104703770922;5777;5782.017057100303;5688.800891968761;5758.049921762904;5798.188253644493;5805.216295800055;5818.796342128006;5341.385740639798;5372.086745253238;5380.381256155553;5393.43368946255;5402.8919421611345;5923.289205295392;5925.229720136354;5926.081457374114;5930.55520835939;5935.554833387513;5481.588880833953;5526.944730552643;5690.772369105272;5691.373948865621;5700.486956173964;5699.658020518782;5741.282339707536;5742.913856292159;5755.194272801811;5830.125481177773;5733.31200255972;5745.1382292656435;5746.482816546447;5747.252857128547;5747.511461525817;5588.804391846266;5736;5741.3971532988435;5741.712914354265;5749.3963133871175;4326.307790753464;4392.209402307615;4451.332300154938;4455.509893911667;4495.213337665896;3939.1924655445564;3947.9605203948167;3948.309045916953;3974.940375894364;3990.3216453203027;5468.7265636718;5470.699111548903;5470.7264636768;5472.972635136878;5478.780848766005;5652.0674088774895;5685.886282274331;5727.083666613322;5738.254026976467;5743.85640358986;5421.674699518042;5440.047991601454;5440.292761940922;5446.754896029688;5493;4931.408231012301;4943.65394422387;4948;4948.628852836052;5003.874903127378;5677.205191273225;5682.318121825242;5741;5741.253637027244;5825.155352473952;5784.21913041734;5791.247137872049;5792.913106303493;5793.15999180125;5794.652320860761;5739.081746920473;5821.09772985188;5824.068149096124;5847;5884.764609415575;5674.602777805514;5685.857853553694;5692.089265717465;5704.2014118024335;5704.3725190228215;5766.221560089334;5767.942320576741;5779.595428319977;5782.45066718661;5783;5475.917861232165;5521.309836270466;5540.473655002768;5589.692566908859;5624;5562.332520097614;5584;5601.775928962796;5638.971805140948;5648.15277708347;5517.972410138084;5551.417101204315;5553.888922221452;5556;5565.053940829987;5500.119980803052;5531.446855314436;5598.440155984369;5625.549956003591;5652.830415087554;5462.180672899097;5538.556915446835;5545.195946587803;5585.273914391103;5591.30108736408 13:11:20 INFO - PROCESS | 20048 | |1;ext.html;562.1960596347225;587.0167469488606;619.0528491408146;621.5369549685485;638.904164375344;31365.68634313659;43106.56893431065;44446.11107777843;44462.1107577849;44562.777186114065;43649.78175109128;44164.11671766563;44294.01353878158;44338.556614433845;44348;8990.325725570592;9127;9139.451632902013;9142.542872856364;9146.817063658722;8976.8653470198;8981.550922453884;9032.729018129467;9076.8638470423;9078.636854525845;9076.59155338008;9095.363324567283;9141.451512909214;9150.40522366044;9151.130642588943;9041.909580904172;9055.728328150166;9074.047225041408;9090.13643703847;9092.499912504843;8913.465192088495;8988.505632190227;8990.910090899073;8991.100889911022;8992.370534062618;41492.1701565967;41790.164196715894;41824.37263441051;41849.37225941613;41855.37216941748;3229.951550726741;3314.5691060162267;3657.9085522861874;3896.7204185551486;3966.504186976628;30855.2286192847;31572.684273157432;31772.682273177204;31795.682043179502;31798.205044873834;4223.366495025771;4400.73595584266;4560.543945605446;4564.041551274237;4572.748498832563;343442;344860;345203;346217;346363.9999999975;57802;58246.70876645589;58264.4173558259;58296;58321.41678583244;60817.69591152016;60830.39169608247;60877.39122608806;60911;60918.69540652357;15668.608284792972;15785.763213551805;15811.920940395454;15827.604309892346;15833.366665333488;12873.549425770054;12883.227006379648;12892.355382230851;12899.226046437056;12906.935465322802;12524.874751252553;16606.169691515377;16736.24686889093;16803.32786688519;16871.240794164292;5158.174692049329;6092.268927728613;6275.6862156891975;6289.622622642656;6291.182146320949;939.4973689076311;1031.9587216511256;1043.780806030742;1085.370485118645;1091.7216109892086;31646.841765791483;32042.839785800923;32066.679333206837;32171.51742723861;32514.512282315784;1074.7957888001254;1075.3279200499687;1098.2367254758026;1101.2566517600587;1134.319408354997;15954.60113497172;16410.83589164117;16795.748063779054;16858;16888.15559222034;509812;515847;516835;517643;517831;56353;56496.71751641216;56566.434335656115;56598.43401566014;56639;1166.6208482243305;1197.4551579031345;1257.7547378261152;1261.735035642507;1280.6734282757836;29539.261518462212;32599.511007335383;33363.666363337026;34923.825380872935;35313.82343088268;54618.72690636521;55131.44868551263;55279.44720552743;55291.723541383646;55363.72318138384;485791;489634;489723;490163;490602;39027.609723902395;39694.60305397025;40055.1988960225;40218.59781402266;40235.79882100571;45842.541574585164;45955.310670339306;46519.76740116413;46826.29760553662;47938.280925786836;38877.80959949541;39587.60412395954;39649.603503964594;40095.799521002205;41479.37780933349;39721;40048.19903601854;40209.331451404585;40654.39018414785;41210.38184427296;39414.80292598519;39704;40292.79853600713;40426.1914761709;40997.59002410057;33627;36045.63954360528;36464.94751846602;36881.63118368782;37077.6292237085;27243.591346129426;27245.591316129878;27732.72267277382;28010.719892801626;28149.577756333263 13:11:20 INFO - PROCESS | 20048 | |2;jquery.html;360.2003552114305;376.5312186328022;403.9131586708857;405.27455854021304;411.47343356148684;13960.930195349021;19430.319938802146;19853.731447738734;20211.59576808463;20450;17757.28970841168;19405.32081377152;19490.902545487254;19556.217751289932;19601;5609.382967873541;5871.412858714137;5877.206577112078;5881.470667639912;5883;5522.5581953443825;5645.689487078209;5661.405552416999;5669.546436285108;5794.971025144869;5567;5633.887322253552;5634.605577609569;5639.605227634067;5641.68970706611;5452.59105567082;5602.943970560304;5688.77244910201;5708.771649134072;5801.6519008859605;5401.297831281948;5610.7194640268235;5618.8033418830555;5620;5625.959197548466;14020.29898505081;14333.068350557285;14414.855851441456;14423.278836058154;14713.485028024075;2066.9689954650694;2286.371247906822;2368.4789346343778;2612.7648511633856;2702.8513431761244;10036.598536058622;10521.105706014998;10547.103496202832;10839.891601083968;13702.93148534261;1754.044045994936;1772.350927473919;1846.1323178106268;1952.9902350488298;1994.9202031918705;77917;78460;78932.60533697352;80052;81414.59292703558;11236.381998990135;11328.32030078198;11455.453513775701;11483.942580287045;11594.47824847867;15801.841981580266;15818.841811581737;15884.682306353809;15888.046717197005;15969.840301597067;8141.633626486704;8207.671693132328;8235.917640823634;8400.957995210107;8535;7665.23347665229;7793.2596403341595;7813.648385822652;7938.444308898322;7974.322182614426;4621.653375996813;4641.303804429363;4642;4720.551547602972;4763.642726795435;1841.3923405276228;1850.8720262755899;1856.4152292027968;1916.3963351544219;1930;846.2510678049847;983.5819776594918;1025.2823023883311;1049.21833234241;1083.7453198498347;18171.909140454212;18928.90535547341;19192.808071919102;19206.903965480084;19539.511512212022;939.793245485992;961.1445813226235;964.320154291223;967.8403063494585;1004.7437903334603;8084.636191371403;10186.388816671024;10549.565923644259;10783.352642366997;10818.088774506445;450491;454797;460633;464206;467763;90878.54560727155;94164;94226;94688.52655736677;94879.52560237155;946.2997381937316;968.7432830299977;969.3263182088522;976.7411635916487;988.6243227573476;16727.74908376351;16789.160541972607;16856.915715421343;17323.653526929644;18141.365052223107;42080.57919420889;42152;42668.5733142677;42720.78639606782;43938.12123757571;58327.4167258322;59630.40369596249;59811;60302.396976031436;60405.39594603998;8480.61837217339;8540.957295213733;8569.48583085017;8892.955535222283;8955.059718729439;12264.32546209967;12508.687282818002;12556.623301300975;13247.536336228186;13266.403011864297;11085.667429977113;11813.232139910879;11859.229150105215;11970.820437693268;12070.517179312728;11417.0866330695;11446.427678616203;11510.654680359603;11567.595134170264;11706.1220408468;11454.484548195185;11487.138464615355;11656.592019279284;11913.523459061887;12100.273983561014;7417.962910185414;7537.246275372639;7651.808704782202;7908.130105688485;8795.91204087951;10698.465076746288;11115.166362523005;11635.185537012328;11788.70528236801;11866.110041746731 13:11:20 INFO - PROCESS | 20048 | |3;mootools.html;1330;1469.3167677030183;1484.5472131000045;1620.9594760130994;1759.1907722447672;7966;8207.30237929776;8507.91492085079;8508.064112947572;8775.473471591693;9093.454392736425;9101.499417532033;9162.86255706165;9177.54112294386;9188.816223675523;2308.1805958884606;2331.545348657004;2331.755165707602;2336.0188720737333;2337.836351455399;2252.5832720946596;2323.6979192704925;2332.5684748321614;2333.125078095714;2339.2982105368405;2165.566886622674;2170.1102547955343;2175.9782402176015;2241.529278851443;2244.8316376271764;2259.5254996450767;2269.3645779181857;2277.7380601230907;2283.805876500491;2293.4381076636246;2275.8975846086964;2280.0309868305903;2288.0618946231966;2288.5880541502524;2289.839711220215;9046.3667543272;9064.954675226647;9131.81736365269;9135.497547634877;9141.405808622418;5353;5501.092319767234;5504.559635229172;5510.0632892408385;5521.089020311644;3545.1137215696076;3583.6595523425235;3628.3650361186687;3670.5778835434;3679.521662183926;1155.537784886044;1159.4492616007412;1163.7905177068124;1165.5046605192758;1168.1180708565064;12912;12922.676933076747;12933.48266069356;12959.416826242841;13033;4487.169873573399;4679.766011699401;4751.738654374042;4799.640026997919;4841.394825646794;10307.433091180057;10310.226732995055;10313.639022634172;10318.071373576415;10322.12261957742;5457.399686034533;5461.371942226695;5463.644863083887;5464.153056276284;5465.344158700902;4430.224710675619;4542.818287268538;4910.410750709938;5084.034033533617;5109.463506331856;3805.4482100095884;3820.656140947328;3870.554886188068;3924.3524818405212;3931;1148.1618418554335;1152.2970987697497;1180.7284324605216;1182.1842928379563;1195.6472840511897;853.470848074198;988.8763904511936;993.7416271769392;996.4668902137322;1009.152312057875;6141.969290153521;6254.186955695731;6280.780172693934;6299.244090709144;6497.805065848032;455.4807519427855;458.19586625472084;459.9862004139881;484.88605177783194;485.16309366343484;4148.647364973951;4313.568643135662;4333.328334108218;4517.141743068806;4547.613452856478;11143.944280278547;11424.143189260838;11480.712982175512;11615.76768464643;11637.418129093512;11544.134189935789;11573.710657233636;11593.130515211393;11596.710082247842;11622.012128968963;8036.557989310527;8403.243708066304;8417.747467575982;8626.741197764077;8635.611397487128;6157.876842463215;6181.752729890754;6279.058141278845;6421.422072013541;6479.84949004837;10184.236182286506;10385.948070259601;10540.841887371542;10555.525001374803;10765.084967777826;10753.784924301626;10807.891921081004;10838;10861.294015888941;10863.293885897392;8037.477563958558;8109.513429194267;8261.83476330482;8275.668973241243;8276.710315138942;8730.825383492167;8744.69393571222;8835.602397892239;8839.69061082859;8849.69026084084;7650.885236721565;7659.540427574363;7665.425093117927;7795.571243581658;8017.438779285628;7579.810504737426;7674.8081297968;7689.231076892266;7836.09884863248;7905.920940790748;7110.32451917067;7304.780856574312;7374.520656157332;7377.4098072155175;7391.223921488381;5209.166533354645;5240.68555886648;5241.947580524146;5319.654222475527;5355.116405793156;5361.169018802092;5371.113766228528;5424.105022671215;5436.565074793928;5475.288212532345 13:11:20 INFO - PROCESS | 20048 | |4;prototype.html;317.98879562989686;321.94365985952453;330.7023678689179;332.90345799718085;337.8749862550857;5239.371275446947;5292.285541451903;5310.814121505743;5315.335583052119;5327.147656374981;4954.876128096799;5102.234664800282;5104.591632669387;5109;5204.661696989693;4045.130296986147;4046.676265898736;4146.3780432935155;4196.916061678765;4200.621944025037;4164.895877603069;4175.770332631704;4177.958220417788;4192.11965487248;4216.177845320164;4050.554439011721;4126.525449573308;4145;4157.48031496063;4158.688098392618;4151.3150330195485;4161.209370219679;4164.729292596002;4176.874693759192;4184.811683474236;3711.1464363196346;3715.2198038411966;3727.9440808387894;3728.422094575318;3752.212035472554;5050.924236136461;5146.974265128688;5159.74201289934;5176.50823171798;5178.352705911761;4736.739479328636;4754.9286760698615;4756.6432517561325;4769.976150119262;4772.689775164603;5485.396606373296;5486.423925487846;5496.422875598085;5500.312460942382;5544.833654990357;3944.44777731115;3954.2882281189372;4066.2146429695754;4069.8168582413864;4085.793671417431;5617.8033768817895;5639.674676451031;5640.661560306354;5653.293338332708;5665.376808551015;4023.4769479967417;4033.495813023372;4056.756594604274;4056.8377264909664;4076.2255171517318;4047;4109.116539943926;4117.732347397409;4127.215828992482;4127.979360103181;4692.436907571113;4713.9764301178275;4715.269133284346;4733.911200423853;4797.064572408347;5454.427285135083;5489.2589500417735;5495.53287970519;5505.807296744595;5507.944920550824;1303.3418123847587;1451.5572750311046;1456.9873937613256;1459.9562013139623;1475.5499572630451;942.4910548303976;983.2183414185597;995.7908839143861;1010.1060561403211;1012.5392946209604;5121.897562048738;5159.355080614923;5204.761952360522;5210.348706411699;5220.3376278097685;5494.148406996842;5536.031194540939;5538.75075621598;5547.55619550443;5548.9722551386985;5105.259737338065;5320.441353657888;5357.1785592898605;5372.3016007919505;5391.433899440581;2951.778616603763;2969.1834745444744;2970.12381347503;2982.6569944456232;2994.296340360014;5496.367917689437;5587.891746352273;5616.326040875121;5663.527482854405;5666.846598292623;5680.557360335013;5682.488576028178;5683.318001839806;5725.59920805548;5738.397468265772;5583.55331573465;5611.653203231195;5619.915701264485;5625.128105143709;5625.465580769738;5343.305370301836;5565.833025009256;5610.831675049755;5693.8861222774485;5700.714964251853;5578.219049333178;5598.244237027949;5611.3266408031295;5614.494695477427;5640.266765320646;5535.446455354432;5680.233168522362;5682.886342273214;5718.399568045295;5749.798757043483;4149;4215.178040282116;4228.661707063489;4252.107057517956;4273.700840941105;5689.431056894277;5721.342045664802;5723.542116630742;5748.166515855261;5752.482276595127;5347.796745732179;5483.341998960151;5530.86172845666;5533.750981205936;5601.159826026129;5453.972730136324;5463.180522921593;5471.835844924659;5474.2062400950845;5493.2034854946605;5184.481551844785;5350.8127215547265;5351.170568561879;5365.812196573102;5414.485623865727;5581.274434323512;5581.972090139523;5586.413426590149;5590.8043218487155;5597.608167428404;5447.12845944647;5453.2365468833605;5460.3993560707495;5463.863403414946;5528.806491772769 13:11:20 INFO - PROCESS | 20048 | |5;yui.html;713.247523862325;718.6442710858124;736.2563810551342;749.9250074992498;810.8418858322626;15628.609284767886;16556.83443165568;17062;17167.055811930353;17198.656026879456;14301.570952871405;14460.927695361535;14490;14499.347529361177;14523.927380363084;655.7016557466342;786.8111653203218;797.1868693932186;798.1140933563769;798.4969469234375;677.6713294052381;779.2363483785894;801.3028665061375;806.7055524733489;807.1363640904235;832.6586099699125;835.678263868412;841.4488510025943;844.666356789068;845.602566793606;676.1885737115432;836.9707060252862;838.1074156023876;838.77353114659;839.1231163434226;509.94645562215806;583.7985894866307;601.0353382820598;602.1569802276804;604.1511676095093;15328.386864525406;15349.155796431192;15379.154146521936;15382.000169988914;15437.459688910834;13796.448142074305;14066.859331406657;14165.362558684885;14272.714545709132;14776;12386.938065309705;12498.750024999448;12511.937440312831;12572.874271257262;12615.243085414813;4230.555791641895;4255.765932873691;4265.210935976854;4316.611504964569;4497.775111244458;80687;81781;82395;84439.15560844375;85783;10904.78190436187;11048.447577621087;11076.723081923017;11113.944430277797;11251.212415130862;21741.23905663294;21803.45491362697;21804.345869623936;21994.560108797734;22009.889950550143;8502.234798868132;8534;8604.139586041345;8673.392862499564;9019.42160121976;4572.9314060289125;4581.358609794632;4596.632269418438;4615.746133962664;4669.182892993713;3428.8628454862023;3523.224890524081;3543.273628906068;3543.291341731664;3547.4324108142573;597.158007209832;603.8188543436951;610.7679081948831;622.7851391270004;631.4664108828033;622.8691974685277;624.9437550620466;638.6998110887876;648.824817299336;652.7193306878088;8369.707060252862;8816.162464565856;8843.823123537493;9164.725058248263;9311.860322095174;535.5528134008147;544.9591280653967;573.6328749600259;575.8560359910023;608.1971797227617;4411.470623525198;4413.646908247397;4625.468071171791;4650;4749.26386410107;121106;121969.39015304866;123983;125567.3721631386;128764;85978.57010714906;89665.55167224252;107678.46160769145;109157;109263;52873.735631322364;54731.72634136804;58810.70594647085;64360;89750;8979.236764874797;9809.509524523603;9991.650292239738;10008.344426122281;10054.34646747959;41753.16493670049;43270.350944736485;48470.27294590513;48482.75758621325;49791.253131202335;70644.64677676579;72554;75737;76794.61602691951;76893;12928.482860685468;13021.674458138623;13168.278990812467;13231.735365292832;13626.046176767532;14475.348609312396;14534.273286335852;14892.925535372688;15194.392224310905;15389.76915346293;12953.222806631633;13081.869181308066;13350.933245333712;13724.382402791698;13833.584992450242;13509.541861148406;13763.31183440844;13941;13995.580132596038;14227.857721423068;12994.675133121747;13428.462861485432;13500.459981600627;13858.514951976633;14278.857211427752;10565.05412855024;10690.946545267223;10710.85782843419;10743.677689669323;11047.116230701686;10967.451627418437;11483.25358851672;11529.769404612029;11563.768724625628;11734.295942243492 13:11:20 INFO - PROCESS | 20048 | __end_tp_report 13:11:20 INFO - PROCESS | 20048 | __start_cc_report 13:11:20 INFO - PROCESS | 20048 | _x_x_mozilla_cycle_collect,1192 13:11:20 INFO - PROCESS | 20048 | __end_cc_report 13:11:20 INFO - PROCESS | 20048 | __startTimestamp1475007080864__endTimestamp 13:11:20 INFO - PROCESS | 20048 | 13:11:20 INFO - PROCESS | 20048 | ------- Summary: start ------- 13:11:20 INFO - PROCESS | 20048 | Number of tests: 6 13:11:20 INFO - PROCESS | 20048 | 13:11:20 INFO - PROCESS | 20048 | [#0] dojo.html Cycles:165 Average:5333.85 Median:5531.45 stddev:595.65 (10.8%) stddev-sans-first:569.19 13:11:20 INFO - PROCESS | 20048 | Values: 3021.8 3046.3 3054.5 3068.0 3095.6 5220.3 5278.5 5344.7 5358.2 5389.4 5304.2 5363.0 5384.7 5428.6 5453.8 4802.3 4842.6 4887.7 4888.7 5014.1 4989.9 5015.6 5033.0 5041.6 5041.9 4811.7 4879.0 4950.3 5003.5 5014.9 4912.1 4912.3 4916.5 4917.8 4918.0 4852.9 4855.7 4863.2 4875.3 4883.9 5281.1 5282.8 5314.0 5378.1 5443.3 5722.3 5765.8 5776.1 5777.0 5782.0 5688.8 5758.0 5798.2 5805.2 5818.8 5341.4 5372.1 5380.4 5393.4 5402.9 5923.3 5925.2 5926.1 5930.6 5935.6 5481.6 5526.9 5690.8 5691.4 5700.5 5699.7 5741.3 5742.9 5755.2 5830.1 5733.3 5745.1 5746.5 5747.3 5747.5 5588.8 5736.0 5741.4 5741.7 5749.4 4326.3 4392.2 4451.3 4455.5 4495.2 3939.2 3948.0 3948.3 3974.9 3990.3 5468.7 5470.7 5470.7 5473.0 5478.8 5652.1 5685.9 5727.1 5738.3 5743.9 5421.7 5440.0 5440.3 5446.8 5493.0 4931.4 4943.7 4948.0 4948.6 5003.9 5677.2 5682.3 5741.0 5741.3 5825.2 5784.2 5791.2 5792.9 5793.2 5794.7 5739.1 5821.1 5824.1 5847.0 5884.8 5674.6 5685.9 5692.1 5704.2 5704.4 5766.2 5767.9 5779.6 5782.5 5783.0 5475.9 5521.3 5540.5 5589.7 5624.0 5562.3 5584.0 5601.8 5639.0 5648.2 5518.0 5551.4 5553.9 5556.0 5565.1 5500.1 5531.4 5598.4 5625.5 5652.8 5462.2 5538.6 5545.2 5585.3 5591.3 13:11:20 INFO - PROCESS | 20048 | 13:11:20 INFO - PROCESS | 20048 | [#1] ext.html Cycles:180 Average:61116.74 Median:41641.17 stddev:120966.51 (290.5%) stddev-sans-first:121220.42 13:11:20 INFO - PROCESS | 20048 | Values: 562.2 587.0 619.1 621.5 638.9 31365.7 43106.6 44446.1 44462.1 44562.8 43649.8 44164.1 44294.0 44338.6 44348.0 8990.3 9127.0 9139.5 9142.5 9146.8 8976.9 8981.6 9032.7 9076.9 9078.6 9076.6 9095.4 9141.5 9150.4 9151.1 9041.9 9055.7 9074.0 9090.1 9092.5 8913.5 8988.5 8990.9 8991.1 8992.4 41492.2 41790.2 41824.4 41849.4 41855.4 3230.0 3314.6 3657.9 3896.7 3966.5 30855.2 31572.7 31772.7 31795.7 31798.2 4223.4 4400.7 4560.5 4564.0 4572.7 343442.0 344860.0 345203.0 346217.0 346364.0 57802.0 58246.7 58264.4 58296.0 58321.4 60817.7 60830.4 60877.4 60911.0 60918.7 15668.6 15785.8 15811.9 15827.6 15833.4 12873.5 12883.2 12892.4 12899.2 12906.9 12524.9 16606.2 16736.2 16803.3 16871.2 5158.2 6092.3 6275.7 6289.6 6291.2 939.5 1032.0 1043.8 1085.4 1091.7 31646.8 32042.8 32066.7 32171.5 32514.5 1074.8 1075.3 1098.2 1101.3 1134.3 15954.6 16410.8 16795.7 16858.0 16888.2 509812.0 515847.0 516835.0 517643.0 517831.0 56353.0 56496.7 56566.4 56598.4 56639.0 1166.6 1197.5 1257.8 1261.7 1280.7 29539.3 32599.5 33363.7 34923.8 35313.8 54618.7 55131.4 55279.4 55291.7 55363.7 485791.0 489634.0 489723.0 490163.0 490602.0 39027.6 39694.6 40055.2 40218.6 40235.8 45842.5 45955.3 46519.8 46826.3 47938.3 38877.8 39587.6 39649.6 40095.8 41479.4 39721.0 40048.2 40209.3 40654.4 41210.4 39414.8 39704.0 40292.8 40426.2 40997.6 33627.0 36045.6 36464.9 36881.6 37077.6 27243.6 27245.6 27732.7 28010.7 28149.6 13:11:20 INFO - PROCESS | 20048 | 13:11:20 INFO - PROCESS | 20048 | [#2] jquery.html Cycles:180 Average:27958.19 Median:404.59 stddev:76033.44 (18792.5%) stddev-sans-first:76218.49 13:11:20 INFO - PROCESS | 20048 | Values: 360.2 376.5 403.9 405.3 411.5 13960.9 19430.3 19853.7 20211.6 20450.0 17757.3 19405.3 19490.9 19556.2 19601.0 5609.4 5871.4 5877.2 5881.5 5883.0 5522.6 5645.7 5661.4 5669.5 5795.0 5567.0 5633.9 5634.6 5639.6 5641.7 5452.6 5602.9 5688.8 5708.8 5801.7 5401.3 5610.7 5618.8 5620.0 5626.0 14020.3 14333.1 14414.9 14423.3 14713.5 2067.0 2286.4 2368.5 2612.8 2702.9 10036.6 10521.1 10547.1 10839.9 13702.9 1754.0 1772.4 1846.1 1953.0 1994.9 77917.0 78460.0 78932.6 80052.0 81414.6 11236.4 11328.3 11455.5 11483.9 11594.5 15801.8 15818.8 15884.7 15888.0 15969.8 8141.6 8207.7 8235.9 8401.0 8535.0 7665.2 7793.3 7813.6 7938.4 7974.3 4621.7 4641.3 4642.0 4720.6 4763.6 1841.4 1850.9 1856.4 1916.4 1930.0 846.3 983.6 1025.3 1049.2 1083.7 18171.9 18928.9 19192.8 19206.9 19539.5 939.8 961.1 964.3 967.8 1004.7 8084.6 10186.4 10549.6 10783.4 10818.1 450491.0 454797.0 460633.0 464206.0 467763.0 90878.5 94164.0 94226.0 94688.5 94879.5 946.3 968.7 969.3 976.7 988.6 16727.7 16789.2 16856.9 17323.7 18141.4 42080.6 42152.0 42668.6 42720.8 43938.1 58327.4 59630.4 59811.0 60302.4 60405.4 8480.6 8541.0 8569.5 8893.0 8955.1 12264.3 12508.7 12556.6 13247.5 13266.4 11085.7 11813.2 11859.2 11970.8 12070.5 11417.1 11446.4 11510.7 11567.6 11706.1 11454.5 11487.1 11656.6 11913.5 12100.3 7418.0 7537.2 7651.8 7908.1 8795.9 10698.5 11115.2 11635.2 11788.7 11866.1 13:11:20 INFO - PROCESS | 20048 | 13:11:20 INFO - PROCESS | 20048 | [#3] mootools.html Cycles:180 Average:5967.12 Median:459.09 stddev:3476.31 (757.2%) stddev-sans-first:3468.59 13:11:20 INFO - PROCESS | 20048 | Values: 1330.0 1469.3 1484.5 1621.0 1759.2 7966.0 8207.3 8507.9 8508.1 8775.5 9093.5 9101.5 9162.9 9177.5 9188.8 2308.2 2331.5 2331.8 2336.0 2337.8 2252.6 2323.7 2332.6 2333.1 2339.3 2165.6 2170.1 2176.0 2241.5 2244.8 2259.5 2269.4 2277.7 2283.8 2293.4 2275.9 2280.0 2288.1 2288.6 2289.8 9046.4 9065.0 9131.8 9135.5 9141.4 5353.0 5501.1 5504.6 5510.1 5521.1 3545.1 3583.7 3628.4 3670.6 3679.5 1155.5 1159.4 1163.8 1165.5 1168.1 12912.0 12922.7 12933.5 12959.4 13033.0 4487.2 4679.8 4751.7 4799.6 4841.4 10307.4 10310.2 10313.6 10318.1 10322.1 5457.4 5461.4 5463.6 5464.2 5465.3 4430.2 4542.8 4910.4 5084.0 5109.5 3805.4 3820.7 3870.6 3924.4 3931.0 1148.2 1152.3 1180.7 1182.2 1195.6 853.5 988.9 993.7 996.5 1009.2 6142.0 6254.2 6280.8 6299.2 6497.8 455.5 458.2 460.0 484.9 485.2 4148.6 4313.6 4333.3 4517.1 4547.6 11143.9 11424.1 11480.7 11615.8 11637.4 11544.1 11573.7 11593.1 11596.7 11622.0 8036.6 8403.2 8417.7 8626.7 8635.6 6157.9 6181.8 6279.1 6421.4 6479.8 10184.2 10385.9 10540.8 10555.5 10765.1 10753.8 10807.9 10838.0 10861.3 10863.3 8037.5 8109.5 8261.8 8275.7 8276.7 8730.8 8744.7 8835.6 8839.7 8849.7 7650.9 7659.5 7665.4 7795.6 8017.4 7579.8 7674.8 7689.2 7836.1 7905.9 7110.3 7304.8 7374.5 7377.4 7391.2 5209.2 5240.7 5241.9 5319.7 5355.1 5361.2 5371.1 5424.1 5436.6 5475.3 13:11:20 INFO - PROCESS | 20048 | 13:11:20 INFO - PROCESS | 20048 | [#4] prototype.html Cycles:180 Average:4639.43 Median:5301.55 stddev:1332.66 (25.1%) stddev-sans-first:1296.32 13:11:20 INFO - PROCESS | 20048 | Values: 318.0 321.9 330.7 332.9 337.9 5239.4 5292.3 5310.8 5315.3 5327.1 4954.9 5102.2 5104.6 5109.0 5204.7 4045.1 4046.7 4146.4 4196.9 4200.6 4164.9 4175.8 4178.0 4192.1 4216.2 4050.6 4126.5 4145.0 4157.5 4158.7 4151.3 4161.2 4164.7 4176.9 4184.8 3711.1 3715.2 3727.9 3728.4 3752.2 5050.9 5147.0 5159.7 5176.5 5178.4 4736.7 4754.9 4756.6 4770.0 4772.7 5485.4 5486.4 5496.4 5500.3 5544.8 3944.4 3954.3 4066.2 4069.8 4085.8 5617.8 5639.7 5640.7 5653.3 5665.4 4023.5 4033.5 4056.8 4056.8 4076.2 4047.0 4109.1 4117.7 4127.2 4128.0 4692.4 4714.0 4715.3 4733.9 4797.1 5454.4 5489.3 5495.5 5505.8 5507.9 1303.3 1451.6 1457.0 1460.0 1475.5 942.5 983.2 995.8 1010.1 1012.5 5121.9 5159.4 5204.8 5210.3 5220.3 5494.1 5536.0 5538.8 5547.6 5549.0 5105.3 5320.4 5357.2 5372.3 5391.4 2951.8 2969.2 2970.1 2982.7 2994.3 5496.4 5587.9 5616.3 5663.5 5666.8 5680.6 5682.5 5683.3 5725.6 5738.4 5583.6 5611.7 5619.9 5625.1 5625.5 5343.3 5565.8 5610.8 5693.9 5700.7 5578.2 5598.2 5611.3 5614.5 5640.3 5535.4 5680.2 5682.9 5718.4 5749.8 4149.0 4215.2 4228.7 4252.1 4273.7 5689.4 5721.3 5723.5 5748.2 5752.5 5347.8 5483.3 5530.9 5533.8 5601.2 5454.0 5463.2 5471.8 5474.2 5493.2 5184.5 5350.8 5351.2 5365.8 5414.5 5581.3 5582.0 5586.4 5590.8 5597.6 5447.1 5453.2 5460.4 5463.9 5528.8 13:11:20 INFO - PROCESS | 20048 | 13:11:20 INFO - PROCESS | 20048 | [#5] yui.html Cycles:180 Average:20575.74 Median:23840.91 stddev:30132.55 (126.4%) stddev-sans-first:30180.17 13:11:20 INFO - PROCESS | 20048 | Values: 713.2 718.6 736.3 749.9 810.8 15628.6 16556.8 17062.0 17167.1 17198.7 14301.6 14460.9 14490.0 14499.3 14523.9 655.7 786.8 797.2 798.1 798.5 677.7 779.2 801.3 806.7 807.1 832.7 835.7 841.4 844.7 845.6 676.2 837.0 838.1 838.8 839.1 509.9 583.8 601.0 602.2 604.2 15328.4 15349.2 15379.2 15382.0 15437.5 13796.4 14066.9 14165.4 14272.7 14776.0 12386.9 12498.8 12511.9 12572.9 12615.2 4230.6 4255.8 4265.2 4316.6 4497.8 80687.0 81781.0 82395.0 84439.2 85783.0 10904.8 11048.4 11076.7 11113.9 11251.2 21741.2 21803.5 21804.3 21994.6 22009.9 8502.2 8534.0 8604.1 8673.4 9019.4 4572.9 4581.4 4596.6 4615.7 4669.2 3428.9 3523.2 3543.3 3543.3 3547.4 597.2 603.8 610.8 622.8 631.5 622.9 624.9 638.7 648.8 652.7 8369.7 8816.2 8843.8 9164.7 9311.9 535.6 545.0 573.6 575.9 608.2 4411.5 4413.6 4625.5 4650.0 4749.3 121106.0 121969.4 123983.0 125567.4 128764.0 85978.6 89665.6 107678.5 109157.0 109263.0 52873.7 54731.7 58810.7 64360.0 89750.0 8979.2 9809.5 9991.7 10008.3 10054.3 41753.2 43270.4 48470.3 48482.8 49791.3 70644.6 72554.0 75737.0 76794.6 76893.0 12928.5 13021.7 13168.3 13231.7 13626.0 14475.3 14534.3 14892.9 15194.4 15389.8 12953.2 13081.9 13350.9 13724.4 13833.6 13509.5 13763.3 13941.0 13995.6 14227.9 12994.7 13428.5 13500.5 13858.5 14278.9 10565.1 10690.9 10710.9 10743.7 11047.1 10967.5 11483.3 11529.8 11563.8 11734.3 13:11:20 INFO - PROCESS | 20048 | -------- Summary: end -------- 13:11:20 INFO - PROCESS | 20048 | 13:11:21 INFO - TEST-INFO | 20048: exit 0 13:11:21 INFO - TEST-OK | dromaeo_css | took 1117590ms 13:11:21 INFO - TEST-START | kraken 13:11:21 INFO - operating with platform_type : linux_ 13:11:21 INFO - Initialising browser for kraken test... 13:11:21 INFO - TEST-INFO | started process 20352 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq5ZZ_r/profile http://localhost:36997/getInfo.html) 13:11:26 INFO - PROCESS | 20352 | __metrics Screen width/height:1600/1200 13:11:26 INFO - PROCESS | 20352 | colorDepth:24 13:11:26 INFO - PROCESS | 20352 | Browser inner width/height: 1024/697 13:11:26 INFO - PROCESS | 20352 | __metrics 13:11:27 INFO - PROCESS | 20352 | 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" 13:11:27 INFO - PROCESS | 20352 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:11:27 INFO - PROCESS | 20352 | console.error: PushService: 13:11:27 INFO - PROCESS | 20352 | stateChangeProcessEnqueue: Error transitioning state 13:11:27 INFO - PROCESS | 20352 | UnknownError 13:11:28 INFO - TEST-INFO | 20352: exit 0 13:11:28 INFO - Browser initialized. 13:11:28 INFO - Running cycle 1/1 for kraken test... 13:11:28 INFO - TEST-INFO | started process 20438 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq5ZZ_r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:11:40 INFO - PROCESS | 20438 | RSS: Main: 174034944 13:11:40 INFO - PROCESS | 20438 | 13:11:43 INFO - PROCESS | 20438 | Cycle 1(1): loaded http://localhost:36997/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36997/tests/kraken/driver.html?testName=audio-beat-detection) 13:11:44 INFO - PROCESS | 20438 | RSS: Main: 232398848 13:11:44 INFO - PROCESS | 20438 | 13:11:46 INFO - PROCESS | 20438 | Cycle 1(1): loaded http://localhost:36997/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36997/tests/kraken/driver.html?testName=audio-dft) 13:11:47 INFO - PROCESS | 20438 | RSS: Main: 216801280 13:11:47 INFO - PROCESS | 20438 | 13:11:50 INFO - PROCESS | 20438 | Cycle 1(1): loaded http://localhost:36997/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36997/tests/kraken/driver.html?testName=audio-fft) 13:11:50 INFO - PROCESS | 20438 | RSS: Main: 298360832 13:11:50 INFO - PROCESS | 20438 | 13:11:53 INFO - PROCESS | 20438 | Cycle 1(1): loaded http://localhost:36997/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36997/tests/kraken/driver.html?testName=audio-oscillator) 13:11:53 INFO - PROCESS | 20438 | RSS: Main: 208474112 13:11:53 INFO - PROCESS | 20438 | 13:11:55 INFO - PROCESS | 20438 | Cycle 1(1): loaded http://localhost:36997/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36997/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:11:56 INFO - PROCESS | 20438 | RSS: Main: 213573632 13:11:56 INFO - PROCESS | 20438 | 13:11:59 INFO - PROCESS | 20438 | Cycle 1(1): loaded http://localhost:36997/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36997/tests/kraken/driver.html?testName=imaging-darkroom) 13:11:59 INFO - PROCESS | 20438 | RSS: Main: 249200640 13:11:59 INFO - PROCESS | 20438 | 13:12:03 INFO - PROCESS | 20438 | Cycle 1(1): loaded http://localhost:36997/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36997/tests/kraken/driver.html?testName=imaging-desaturate) 13:12:03 INFO - PROCESS | 20438 | RSS: Main: 248455168 13:12:03 INFO - PROCESS | 20438 | 13:12:06 INFO - PROCESS | 20438 | Cycle 1(1): loaded http://localhost:36997/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36997/tests/kraken/driver.html?testName=json-parse-financial) 13:12:07 INFO - PROCESS | 20438 | RSS: Main: 248553472 13:12:07 INFO - PROCESS | 20438 | 13:12:08 INFO - PROCESS | 20438 | Cycle 1(1): loaded http://localhost:36997/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36997/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:12:09 INFO - PROCESS | 20438 | RSS: Main: 210685952 13:12:09 INFO - PROCESS | 20438 | 13:12:11 INFO - PROCESS | 20438 | Cycle 1(1): loaded http://localhost:36997/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36997/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:12:11 INFO - PROCESS | 20438 | RSS: Main: 217673728 13:12:11 INFO - PROCESS | 20438 | 13:12:13 INFO - PROCESS | 20438 | Cycle 1(1): loaded http://localhost:36997/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36997/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:12:14 INFO - PROCESS | 20438 | RSS: Main: 222728192 13:12:14 INFO - PROCESS | 20438 | 13:12:17 INFO - PROCESS | 20438 | Cycle 1(1): loaded http://localhost:36997/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36997/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:12:17 INFO - PROCESS | 20438 | RSS: Main: 223473664 13:12:17 INFO - PROCESS | 20438 | 13:12:20 INFO - PROCESS | 20438 | Cycle 1(1): loaded http://localhost:36997/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36997/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:12:21 INFO - PROCESS | 20438 | RSS: Main: 221814784 13:12:21 INFO - PROCESS | 20438 | 13:12:22 INFO - PROCESS | 20438 | Cycle 1(1): loaded http://localhost:36997/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36997/tests/kraken/driver.html?testName=ai-astar) 13:12:22 INFO - PROCESS | 20438 | RSS: Main: 272609280 13:12:22 INFO - PROCESS | 20438 | 13:12:22 INFO - PROCESS | 20438 | __start_tp_report 13:12:22 INFO - PROCESS | 20438 | _x_x_mozilla_page_load 13:12:22 INFO - PROCESS | 20438 | _x_x_mozilla_page_load_details 13:12:22 INFO - PROCESS | 20438 | |i|pagename|runs| 13:12:22 INFO - PROCESS | 20438 | |0;ai-astar;109;112;111;110;111;111;112;112;111;111 13:12:22 INFO - PROCESS | 20438 | |1;audio-beat-detection;152;118;118;164;121;119;116;116;147;117 13:12:22 INFO - PROCESS | 20438 | |2;audio-dft;160;161;162;162;161;160;160;161;161;161 13:12:22 INFO - PROCESS | 20438 | |3;audio-fft;74;75;75;108;76;75;76;75;99;75 13:12:22 INFO - PROCESS | 20438 | |4;audio-oscillator;83;83;122;82;83;82;100;82;81;114 13:12:22 INFO - PROCESS | 20438 | |5;imaging-gaussian-blur;117;117;118;116;116;117;117;116;117;117 13:12:22 INFO - PROCESS | 20438 | |6;imaging-darkroom;146;145;145;145;145;146;145;146;146;146 13:12:22 INFO - PROCESS | 20438 | |7;imaging-desaturate;96;96;96;95;96;95;95;95;95;97 13:12:22 INFO - PROCESS | 20438 | |8;json-parse-financial;52;51;52;52;53;52;54;51;52;51 13:12:22 INFO - PROCESS | 20438 | |9;json-stringify-tinderbox;60;60;60;60;60;61;60;61;60;60 13:12:22 INFO - PROCESS | 20438 | |10;stanford-crypto-aes;84;84;78;78;79;79;81;83;80;80 13:12:22 INFO - PROCESS | 20438 | |11;stanford-crypto-ccm;134;125;130;121;132;132;122;130;155;141 13:12:22 INFO - PROCESS | 20438 | |12;stanford-crypto-pbkdf2;167;168;165;163;164;163;162;162;164;165 13:12:22 INFO - PROCESS | 20438 | |13;stanford-crypto-sha256-iterative;63;66;64;65;64;64;64;67;63;65 13:12:22 INFO - PROCESS | 20438 | __end_tp_report 13:12:22 INFO - PROCESS | 20438 | __start_cc_report 13:12:22 INFO - PROCESS | 20438 | _x_x_mozilla_cycle_collect,1639 13:12:22 INFO - PROCESS | 20438 | __end_cc_report 13:12:22 INFO - PROCESS | 20438 | __startTimestamp1475007142931__endTimestamp 13:12:22 INFO - PROCESS | 20438 | 13:12:22 INFO - PROCESS | 20438 | ------- Summary: start ------- 13:12:22 INFO - PROCESS | 20438 | Number of tests: 14 13:12:22 INFO - PROCESS | 20438 | 13:12:22 INFO - PROCESS | 20438 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.00 stddev:0.94 (0.8%) stddev-sans-first:0.67 13:12:22 INFO - PROCESS | 20438 | Values: 109.0 112.0 111.0 110.0 111.0 111.0 112.0 112.0 111.0 111.0 13:12:22 INFO - PROCESS | 20438 | 13:12:22 INFO - PROCESS | 20438 | [#1] audio-beat-detection Cycles:10 Average:128.80 Median:120.00 stddev:18.15 (15.1%) stddev-sans-first:17.20 13:12:22 INFO - PROCESS | 20438 | Values: 152.0 118.0 118.0 164.0 121.0 119.0 116.0 116.0 147.0 117.0 13:12:22 INFO - PROCESS | 20438 | 13:12:22 INFO - PROCESS | 20438 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 13:12:22 INFO - PROCESS | 20438 | Values: 160.0 161.0 162.0 162.0 161.0 160.0 160.0 161.0 161.0 161.0 13:12:22 INFO - PROCESS | 20438 | 13:12:22 INFO - PROCESS | 20438 | [#3] audio-fft Cycles:10 Average:80.80 Median:75.00 stddev:12.16 (16.2%) stddev-sans-first:12.65 13:12:22 INFO - PROCESS | 20438 | Values: 74.0 75.0 75.0 108.0 76.0 75.0 76.0 75.0 99.0 75.0 13:12:22 INFO - PROCESS | 20438 | 13:12:22 INFO - PROCESS | 20438 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:82.00 stddev:15.30 (18.7%) stddev-sans-first:15.93 13:12:22 INFO - PROCESS | 20438 | Values: 83.0 83.0 122.0 82.0 83.0 82.0 100.0 82.0 81.0 114.0 13:12:22 INFO - PROCESS | 20438 | 13:12:22 INFO - PROCESS | 20438 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 13:12:22 INFO - PROCESS | 20438 | Values: 117.0 117.0 118.0 116.0 116.0 117.0 117.0 116.0 117.0 117.0 13:12:22 INFO - PROCESS | 20438 | 13:12:22 INFO - PROCESS | 20438 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 13:12:22 INFO - PROCESS | 20438 | Values: 146.0 145.0 145.0 145.0 145.0 146.0 145.0 146.0 146.0 146.0 13:12:22 INFO - PROCESS | 20438 | 13:12:22 INFO - PROCESS | 20438 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 13:12:22 INFO - PROCESS | 20438 | Values: 96.0 96.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 97.0 13:12:22 INFO - PROCESS | 20438 | 13:12:22 INFO - PROCESS | 20438 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:0.94 (1.8%) stddev-sans-first:1.00 13:12:22 INFO - PROCESS | 20438 | Values: 52.0 51.0 52.0 52.0 53.0 52.0 54.0 51.0 52.0 51.0 13:12:22 INFO - PROCESS | 20438 | 13:12:22 INFO - PROCESS | 20438 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 13:12:22 INFO - PROCESS | 20438 | Values: 60.0 60.0 60.0 60.0 60.0 61.0 60.0 61.0 60.0 60.0 13:12:22 INFO - PROCESS | 20438 | 13:12:22 INFO - PROCESS | 20438 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:80.50 stddev:2.32 (2.9%) stddev-sans-first:2.11 13:12:22 INFO - PROCESS | 20438 | Values: 84.0 84.0 78.0 78.0 79.0 79.0 81.0 83.0 80.0 80.0 13:12:22 INFO - PROCESS | 20438 | 13:12:22 INFO - PROCESS | 20438 | [#11] stanford-crypto-ccm Cycles:10 Average:132.20 Median:132.00 stddev:9.95 (7.5%) stddev-sans-first:10.54 13:12:22 INFO - PROCESS | 20438 | Values: 134.0 125.0 130.0 121.0 132.0 132.0 122.0 130.0 155.0 141.0 13:12:22 INFO - PROCESS | 20438 | 13:12:22 INFO - PROCESS | 20438 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.30 Median:164.50 stddev:2.00 (1.2%) stddev-sans-first:1.87 13:12:22 INFO - PROCESS | 20438 | Values: 167.0 168.0 165.0 163.0 164.0 163.0 162.0 162.0 164.0 165.0 13:12:22 INFO - PROCESS | 20438 | 13:12:22 INFO - PROCESS | 20438 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:64.50 stddev:1.27 (2.0%) stddev-sans-first:1.22 13:12:22 INFO - PROCESS | 20438 | Values: 63.0 66.0 64.0 65.0 64.0 64.0 64.0 67.0 63.0 65.0 13:12:22 INFO - PROCESS | 20438 | -------- Summary: end -------- 13:12:22 INFO - PROCESS | 20438 | 13:12:24 INFO - TEST-INFO | 20438: exit 0 13:12:24 INFO - TEST-OK | kraken | took 62387ms 13:12:24 INFO - SUITE-END | took 1179s 13:12:24 INFO - Completed test suite (00:19:40) 13:12:24 INFO - javascript benchmark 13:12:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3021.80358276712, 3046.2688954650876, 3054.480738274494, 3068.0335694256323, 3095.6440009398925, 5220.347456567929, 5278.524932756051, 5344.652597581155, 5358.196270559418, 5389.434109418514, 5304.177852432869, 5363.034653762321, 5384.703841288728, 5428.565714742821, 5453.754581043852, 4802.279658051303, 4842.564169224769, 4887.7311747853855, 4888.706677599355, 5014.147594908874, 4989.850304490871, 5015.623828212881, 5033.043721692867, 5041.571466425358, 5041.924371134418, 4811.711297322172, 4879.048585525824, 4950.257461380804, 5003.4746351633285, 5014.899702005958, 4912.091263116335, 4912.287718280829, 4916.483769204217, 4917.754112294371, 4917.950820491785, 4852.878678033042, 4855.6601037927, 4863.19757240055, 4875.268709693539, 4883.902321953577, 5281.12861377876, 5282.788688452457, 5313.973430132824, 5378.085725426687, 5443.319585051869, 5722.313322401297, 5765.798197063083, 5776.104703770922, 5777.0, 5782.017057100303, 5688.800891968761, 5758.049921762904, 5798.188253644493, 5805.216295800055, 5818.796342128006, 5341.385740639798, 5372.086745253238, 5380.381256155553, 5393.43368946255, 5402.8919421611345, 5923.289205295392, 5925.229720136354, 5926.081457374114, 5930.55520835939, 5935.554833387513, 5481.588880833953, 5526.944730552643, 5690.772369105272, 5691.373948865621, 5700.486956173964, 5699.658020518782, 5741.282339707536, 5742.913856292159, 5755.194272801811, 5830.125481177773, 5733.31200255972, 5745.1382292656435, 5746.482816546447, 5747.252857128547, 5747.511461525817, 5588.804391846266, 5736.0, 5741.3971532988435, 5741.712914354265, 5749.3963133871175, 4326.307790753464, 4392.209402307615, 4451.332300154938, 4455.509893911667, 4495.213337665896, 3939.1924655445564, 3947.9605203948167, 3948.309045916953, 3974.940375894364, 3990.3216453203027, 5468.7265636718, 5470.699111548903, 5470.7264636768, 5472.972635136878, 5478.780848766005, 5652.0674088774895, 5685.886282274331, 5727.083666613322, 5738.254026976467, 5743.85640358986, 5421.674699518042, 5440.047991601454, 5440.292761940922, 5446.754896029688, 5493.0, 4931.408231012301, 4943.65394422387, 4948.0, 4948.628852836052, 5003.874903127378, 5677.205191273225, 5682.318121825242, 5741.0, 5741.253637027244, 5825.155352473952, 5784.21913041734, 5791.247137872049, 5792.913106303493, 5793.15999180125, 5794.652320860761, 5739.081746920473, 5821.09772985188, 5824.068149096124, 5847.0, 5884.764609415575, 5674.602777805514, 5685.857853553694, 5692.089265717465, 5704.2014118024335, 5704.3725190228215, 5766.221560089334, 5767.942320576741, 5779.595428319977, 5782.45066718661, 5783.0, 5475.917861232165, 5521.309836270466, 5540.473655002768, 5589.692566908859, 5624.0, 5562.332520097614, 5584.0, 5601.775928962796, 5638.971805140948, 5648.15277708347, 5517.972410138084, 5551.417101204315, 5553.888922221452, 5556.0, 5565.053940829987, 5500.119980803052, 5531.446855314436, 5598.440155984369, 5625.549956003591, 5652.830415087554, 5462.180672899097, 5538.556915446835, 5545.195946587803, 5585.273914391103, 5591.30108736408], "value": 5293.6468240453805, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.1960596347225, 587.0167469488606, 619.0528491408146, 621.5369549685485, 638.904164375344, 31365.68634313659, 43106.56893431065, 44446.11107777843, 44462.1107577849, 44562.777186114065, 43649.78175109128, 44164.11671766563, 44294.01353878158, 44338.556614433845, 44348.0, 8990.325725570592, 9127.0, 9139.451632902013, 9142.542872856364, 9146.817063658722, 8976.8653470198, 8981.550922453884, 9032.729018129467, 9076.8638470423, 9078.636854525845, 9076.59155338008, 9095.363324567283, 9141.451512909214, 9150.40522366044, 9151.130642588943, 9041.909580904172, 9055.728328150166, 9074.047225041408, 9090.13643703847, 9092.499912504843, 8913.465192088495, 8988.505632190227, 8990.910090899073, 8991.100889911022, 8992.370534062618, 41492.1701565967, 41790.164196715894, 41824.37263441051, 41849.37225941613, 41855.37216941748, 3229.951550726741, 3314.5691060162267, 3657.9085522861874, 3896.7204185551486, 3966.504186976628, 30855.2286192847, 31572.684273157432, 31772.682273177204, 31795.682043179502, 31798.205044873834, 4223.366495025771, 4400.73595584266, 4560.543945605446, 4564.041551274237, 4572.748498832563, 343442.0, 344860.0, 345203.0, 346217.0, 346363.9999999975, 57802.0, 58246.70876645589, 58264.4173558259, 58296.0, 58321.41678583244, 60817.69591152016, 60830.39169608247, 60877.39122608806, 60911.0, 60918.69540652357, 15668.608284792972, 15785.763213551805, 15811.920940395454, 15827.604309892346, 15833.366665333488, 12873.549425770054, 12883.227006379648, 12892.355382230851, 12899.226046437056, 12906.935465322802, 12524.874751252553, 16606.169691515377, 16736.24686889093, 16803.32786688519, 16871.240794164292, 5158.174692049329, 6092.268927728613, 6275.6862156891975, 6289.622622642656, 6291.182146320949, 939.4973689076311, 1031.9587216511256, 1043.780806030742, 1085.370485118645, 1091.7216109892086, 31646.841765791483, 32042.839785800923, 32066.679333206837, 32171.51742723861, 32514.512282315784, 1074.7957888001254, 1075.3279200499687, 1098.2367254758026, 1101.2566517600587, 1134.319408354997, 15954.60113497172, 16410.83589164117, 16795.748063779054, 16858.0, 16888.15559222034, 509812.0, 515847.0, 516835.0, 517643.0, 517831.0, 56353.0, 56496.71751641216, 56566.434335656115, 56598.43401566014, 56639.0, 1166.6208482243305, 1197.4551579031345, 1257.7547378261152, 1261.735035642507, 1280.6734282757836, 29539.261518462212, 32599.511007335383, 33363.666363337026, 34923.825380872935, 35313.82343088268, 54618.72690636521, 55131.44868551263, 55279.44720552743, 55291.723541383646, 55363.72318138384, 485791.0, 489634.0, 489723.0, 490163.0, 490602.0, 39027.609723902395, 39694.60305397025, 40055.1988960225, 40218.59781402266, 40235.79882100571, 45842.541574585164, 45955.310670339306, 46519.76740116413, 46826.29760553662, 47938.280925786836, 38877.80959949541, 39587.60412395954, 39649.603503964594, 40095.799521002205, 41479.37780933349, 39721.0, 40048.19903601854, 40209.331451404585, 40654.39018414785, 41210.38184427296, 39414.80292598519, 39704.0, 40292.79853600713, 40426.1914761709, 40997.59002410057, 33627.0, 36045.63954360528, 36464.94751846602, 36881.63118368782, 37077.6292237085, 27243.591346129426, 27245.591316129878, 27732.72267277382, 28010.719892801626, 28149.577756333263], "value": 20089.8370225573, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.2003552114305, 376.5312186328022, 403.9131586708857, 405.27455854021304, 411.47343356148684, 13960.930195349021, 19430.319938802146, 19853.731447738734, 20211.59576808463, 20450.0, 17757.28970841168, 19405.32081377152, 19490.902545487254, 19556.217751289932, 19601.0, 5609.382967873541, 5871.412858714137, 5877.206577112078, 5881.470667639912, 5883.0, 5522.5581953443825, 5645.689487078209, 5661.405552416999, 5669.546436285108, 5794.971025144869, 5567.0, 5633.887322253552, 5634.605577609569, 5639.605227634067, 5641.68970706611, 5452.59105567082, 5602.943970560304, 5688.77244910201, 5708.771649134072, 5801.6519008859605, 5401.297831281948, 5610.7194640268235, 5618.8033418830555, 5620.0, 5625.959197548466, 14020.29898505081, 14333.068350557285, 14414.855851441456, 14423.278836058154, 14713.485028024075, 2066.9689954650694, 2286.371247906822, 2368.4789346343778, 2612.7648511633856, 2702.8513431761244, 10036.598536058622, 10521.105706014998, 10547.103496202832, 10839.891601083968, 13702.93148534261, 1754.044045994936, 1772.350927473919, 1846.1323178106268, 1952.9902350488298, 1994.9202031918705, 77917.0, 78460.0, 78932.60533697352, 80052.0, 81414.59292703558, 11236.381998990135, 11328.32030078198, 11455.453513775701, 11483.942580287045, 11594.47824847867, 15801.841981580266, 15818.841811581737, 15884.682306353809, 15888.046717197005, 15969.840301597067, 8141.633626486704, 8207.671693132328, 8235.917640823634, 8400.957995210107, 8535.0, 7665.23347665229, 7793.2596403341595, 7813.648385822652, 7938.444308898322, 7974.322182614426, 4621.653375996813, 4641.303804429363, 4642.0, 4720.551547602972, 4763.642726795435, 1841.3923405276228, 1850.8720262755899, 1856.4152292027968, 1916.3963351544219, 1930.0, 846.2510678049847, 983.5819776594918, 1025.2823023883311, 1049.21833234241, 1083.7453198498347, 18171.909140454212, 18928.90535547341, 19192.808071919102, 19206.903965480084, 19539.511512212022, 939.793245485992, 961.1445813226235, 964.320154291223, 967.8403063494585, 1004.7437903334603, 8084.636191371403, 10186.388816671024, 10549.565923644259, 10783.352642366997, 10818.088774506445, 450491.0, 454797.0, 460633.0, 464206.0, 467763.0, 90878.54560727155, 94164.0, 94226.0, 94688.52655736677, 94879.52560237155, 946.2997381937316, 968.7432830299977, 969.3263182088522, 976.7411635916487, 988.6243227573476, 16727.74908376351, 16789.160541972607, 16856.915715421343, 17323.653526929644, 18141.365052223107, 42080.57919420889, 42152.0, 42668.5733142677, 42720.78639606782, 43938.12123757571, 58327.4167258322, 59630.40369596249, 59811.0, 60302.396976031436, 60405.39594603998, 8480.61837217339, 8540.957295213733, 8569.48583085017, 8892.955535222283, 8955.059718729439, 12264.32546209967, 12508.687282818002, 12556.623301300975, 13247.536336228186, 13266.403011864297, 11085.667429977113, 11813.232139910879, 11859.229150105215, 11970.820437693268, 12070.517179312728, 11417.0866330695, 11446.427678616203, 11510.654680359603, 11567.595134170264, 11706.1220408468, 11454.484548195185, 11487.138464615355, 11656.592019279284, 11913.523459061887, 12100.273983561014, 7417.962910185414, 7537.246275372639, 7651.808704782202, 7908.130105688485, 8795.91204087951, 10698.465076746288, 11115.166362523005, 11635.185537012328, 11788.70528236801, 11866.110041746731], "value": 9037.941782468799, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1330.0, 1469.3167677030183, 1484.5472131000045, 1620.9594760130994, 1759.1907722447672, 7966.0, 8207.30237929776, 8507.91492085079, 8508.064112947572, 8775.473471591693, 9093.454392736425, 9101.499417532033, 9162.86255706165, 9177.54112294386, 9188.816223675523, 2308.1805958884606, 2331.545348657004, 2331.755165707602, 2336.0188720737333, 2337.836351455399, 2252.5832720946596, 2323.6979192704925, 2332.5684748321614, 2333.125078095714, 2339.2982105368405, 2165.566886622674, 2170.1102547955343, 2175.9782402176015, 2241.529278851443, 2244.8316376271764, 2259.5254996450767, 2269.3645779181857, 2277.7380601230907, 2283.805876500491, 2293.4381076636246, 2275.8975846086964, 2280.0309868305903, 2288.0618946231966, 2288.5880541502524, 2289.839711220215, 9046.3667543272, 9064.954675226647, 9131.81736365269, 9135.497547634877, 9141.405808622418, 5353.0, 5501.092319767234, 5504.559635229172, 5510.0632892408385, 5521.089020311644, 3545.1137215696076, 3583.6595523425235, 3628.3650361186687, 3670.5778835434, 3679.521662183926, 1155.537784886044, 1159.4492616007412, 1163.7905177068124, 1165.5046605192758, 1168.1180708565064, 12912.0, 12922.676933076747, 12933.48266069356, 12959.416826242841, 13033.0, 4487.169873573399, 4679.766011699401, 4751.738654374042, 4799.640026997919, 4841.394825646794, 10307.433091180057, 10310.226732995055, 10313.639022634172, 10318.071373576415, 10322.12261957742, 5457.399686034533, 5461.371942226695, 5463.644863083887, 5464.153056276284, 5465.344158700902, 4430.224710675619, 4542.818287268538, 4910.410750709938, 5084.034033533617, 5109.463506331856, 3805.4482100095884, 3820.656140947328, 3870.554886188068, 3924.3524818405212, 3931.0, 1148.1618418554335, 1152.2970987697497, 1180.7284324605216, 1182.1842928379563, 1195.6472840511897, 853.470848074198, 988.8763904511936, 993.7416271769392, 996.4668902137322, 1009.152312057875, 6141.969290153521, 6254.186955695731, 6280.780172693934, 6299.244090709144, 6497.805065848032, 455.4807519427855, 458.19586625472084, 459.9862004139881, 484.88605177783194, 485.16309366343484, 4148.647364973951, 4313.568643135662, 4333.328334108218, 4517.141743068806, 4547.613452856478, 11143.944280278547, 11424.143189260838, 11480.712982175512, 11615.76768464643, 11637.418129093512, 11544.134189935789, 11573.710657233636, 11593.130515211393, 11596.710082247842, 11622.012128968963, 8036.557989310527, 8403.243708066304, 8417.747467575982, 8626.741197764077, 8635.611397487128, 6157.876842463215, 6181.752729890754, 6279.058141278845, 6421.422072013541, 6479.84949004837, 10184.236182286506, 10385.948070259601, 10540.841887371542, 10555.525001374803, 10765.084967777826, 10753.784924301626, 10807.891921081004, 10838.0, 10861.294015888941, 10863.293885897392, 8037.477563958558, 8109.513429194267, 8261.83476330482, 8275.668973241243, 8276.710315138942, 8730.825383492167, 8744.69393571222, 8835.602397892239, 8839.69061082859, 8849.69026084084, 7650.885236721565, 7659.540427574363, 7665.425093117927, 7795.571243581658, 8017.438779285628, 7579.810504737426, 7674.8081297968, 7689.231076892266, 7836.09884863248, 7905.920940790748, 7110.32451917067, 7304.780856574312, 7374.520656157332, 7377.4098072155175, 7391.223921488381, 5209.166533354645, 5240.68555886648, 5241.947580524146, 5319.654222475527, 5355.116405793156, 5361.169018802092, 5371.113766228528, 5424.105022671215, 5436.565074793928, 5475.288212532345], "value": 4646.379083566704, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.98879562989686, 321.94365985952453, 330.7023678689179, 332.90345799718085, 337.8749862550857, 5239.371275446947, 5292.285541451903, 5310.814121505743, 5315.335583052119, 5327.147656374981, 4954.876128096799, 5102.234664800282, 5104.591632669387, 5109.0, 5204.661696989693, 4045.130296986147, 4046.676265898736, 4146.3780432935155, 4196.916061678765, 4200.621944025037, 4164.895877603069, 4175.770332631704, 4177.958220417788, 4192.11965487248, 4216.177845320164, 4050.554439011721, 4126.525449573308, 4145.0, 4157.48031496063, 4158.688098392618, 4151.3150330195485, 4161.209370219679, 4164.729292596002, 4176.874693759192, 4184.811683474236, 3711.1464363196346, 3715.2198038411966, 3727.9440808387894, 3728.422094575318, 3752.212035472554, 5050.924236136461, 5146.974265128688, 5159.74201289934, 5176.50823171798, 5178.352705911761, 4736.739479328636, 4754.9286760698615, 4756.6432517561325, 4769.976150119262, 4772.689775164603, 5485.396606373296, 5486.423925487846, 5496.422875598085, 5500.312460942382, 5544.833654990357, 3944.44777731115, 3954.2882281189372, 4066.2146429695754, 4069.8168582413864, 4085.793671417431, 5617.8033768817895, 5639.674676451031, 5640.661560306354, 5653.293338332708, 5665.376808551015, 4023.4769479967417, 4033.495813023372, 4056.756594604274, 4056.8377264909664, 4076.2255171517318, 4047.0, 4109.116539943926, 4117.732347397409, 4127.215828992482, 4127.979360103181, 4692.436907571113, 4713.9764301178275, 4715.269133284346, 4733.911200423853, 4797.064572408347, 5454.427285135083, 5489.2589500417735, 5495.53287970519, 5505.807296744595, 5507.944920550824, 1303.3418123847587, 1451.5572750311046, 1456.9873937613256, 1459.9562013139623, 1475.5499572630451, 942.4910548303976, 983.2183414185597, 995.7908839143861, 1010.1060561403211, 1012.5392946209604, 5121.897562048738, 5159.355080614923, 5204.761952360522, 5210.348706411699, 5220.3376278097685, 5494.148406996842, 5536.031194540939, 5538.75075621598, 5547.55619550443, 5548.9722551386985, 5105.259737338065, 5320.441353657888, 5357.1785592898605, 5372.3016007919505, 5391.433899440581, 2951.778616603763, 2969.1834745444744, 2970.12381347503, 2982.6569944456232, 2994.296340360014, 5496.367917689437, 5587.891746352273, 5616.326040875121, 5663.527482854405, 5666.846598292623, 5680.557360335013, 5682.488576028178, 5683.318001839806, 5725.59920805548, 5738.397468265772, 5583.55331573465, 5611.653203231195, 5619.915701264485, 5625.128105143709, 5625.465580769738, 5343.305370301836, 5565.833025009256, 5610.831675049755, 5693.8861222774485, 5700.714964251853, 5578.219049333178, 5598.244237027949, 5611.3266408031295, 5614.494695477427, 5640.266765320646, 5535.446455354432, 5680.233168522362, 5682.886342273214, 5718.399568045295, 5749.798757043483, 4149.0, 4215.178040282116, 4228.661707063489, 4252.107057517956, 4273.700840941105, 5689.431056894277, 5721.342045664802, 5723.542116630742, 5748.166515855261, 5752.482276595127, 5347.796745732179, 5483.341998960151, 5530.86172845666, 5533.750981205936, 5601.159826026129, 5453.972730136324, 5463.180522921593, 5471.835844924659, 5474.2062400950845, 5493.2034854946605, 5184.481551844785, 5350.8127215547265, 5351.170568561879, 5365.812196573102, 5414.485623865727, 5581.274434323512, 5581.972090139523, 5586.413426590149, 5590.8043218487155, 5597.608167428404, 5447.12845944647, 5453.2365468833605, 5460.3993560707495, 5463.863403414946, 5528.806491772769], "value": 4216.358293837333, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.247523862325, 718.6442710858124, 736.2563810551342, 749.9250074992498, 810.8418858322626, 15628.609284767886, 16556.83443165568, 17062.0, 17167.055811930353, 17198.656026879456, 14301.570952871405, 14460.927695361535, 14490.0, 14499.347529361177, 14523.927380363084, 655.7016557466342, 786.8111653203218, 797.1868693932186, 798.1140933563769, 798.4969469234375, 677.6713294052381, 779.2363483785894, 801.3028665061375, 806.7055524733489, 807.1363640904235, 832.6586099699125, 835.678263868412, 841.4488510025943, 844.666356789068, 845.602566793606, 676.1885737115432, 836.9707060252862, 838.1074156023876, 838.77353114659, 839.1231163434226, 509.94645562215806, 583.7985894866307, 601.0353382820598, 602.1569802276804, 604.1511676095093, 15328.386864525406, 15349.155796431192, 15379.154146521936, 15382.000169988914, 15437.459688910834, 13796.448142074305, 14066.859331406657, 14165.362558684885, 14272.714545709132, 14776.0, 12386.938065309705, 12498.750024999448, 12511.937440312831, 12572.874271257262, 12615.243085414813, 4230.555791641895, 4255.765932873691, 4265.210935976854, 4316.611504964569, 4497.775111244458, 80687.0, 81781.0, 82395.0, 84439.15560844375, 85783.0, 10904.78190436187, 11048.447577621087, 11076.723081923017, 11113.944430277797, 11251.212415130862, 21741.23905663294, 21803.45491362697, 21804.345869623936, 21994.560108797734, 22009.889950550143, 8502.234798868132, 8534.0, 8604.139586041345, 8673.392862499564, 9019.42160121976, 4572.9314060289125, 4581.358609794632, 4596.632269418438, 4615.746133962664, 4669.182892993713, 3428.8628454862023, 3523.224890524081, 3543.273628906068, 3543.291341731664, 3547.4324108142573, 597.158007209832, 603.8188543436951, 610.7679081948831, 622.7851391270004, 631.4664108828033, 622.8691974685277, 624.9437550620466, 638.6998110887876, 648.824817299336, 652.7193306878088, 8369.707060252862, 8816.162464565856, 8843.823123537493, 9164.725058248263, 9311.860322095174, 535.5528134008147, 544.9591280653967, 573.6328749600259, 575.8560359910023, 608.1971797227617, 4411.470623525198, 4413.646908247397, 4625.468071171791, 4650.0, 4749.26386410107, 121106.0, 121969.39015304866, 123983.0, 125567.3721631386, 128764.0, 85978.57010714906, 89665.55167224252, 107678.46160769145, 109157.0, 109263.0, 52873.735631322364, 54731.72634136804, 58810.70594647085, 64360.0, 89750.0, 8979.236764874797, 9809.509524523603, 9991.650292239738, 10008.344426122281, 10054.34646747959, 41753.16493670049, 43270.350944736485, 48470.27294590513, 48482.75758621325, 49791.253131202335, 70644.64677676579, 72554.0, 75737.0, 76794.61602691951, 76893.0, 12928.482860685468, 13021.674458138623, 13168.278990812467, 13231.735365292832, 13626.046176767532, 14475.348609312396, 14534.273286335852, 14892.925535372688, 15194.392224310905, 15389.76915346293, 12953.222806631633, 13081.869181308066, 13350.933245333712, 13724.382402791698, 13833.584992450242, 13509.541861148406, 13763.31183440844, 13941.0, 13995.580132596038, 14227.857721423068, 12994.675133121747, 13428.462861485432, 13500.459981600627, 13858.514951976633, 14278.857211427752, 10565.05412855024, 10690.946545267223, 10710.85782843419, 10743.677689669323, 11047.116230701686, 10967.451627418437, 11483.25358851672, 11529.769404612029, 11563.768724625628, 11734.295942243492], "value": 7415.658538339537, "unit": "score"}], "name": "dromaeo_css", "value": 7202.909524081962, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 111.0, 110.0, 111.0, 111.0, 112.0, 112.0, 111.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 118.0, 118.0, 164.0, 121.0, 119.0, 116.0, 116.0, 147.0, 117.0], "value": 128.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 162.0, 162.0, 161.0, 160.0, 160.0, 161.0, 161.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 108.0, 76.0, 75.0, 76.0, 75.0, 99.0, 75.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 122.0, 82.0, 83.0, 82.0, 100.0, 82.0, 81.0, 114.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 97.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 52.0, 52.0, 53.0, 52.0, 54.0, 51.0, 52.0, 51.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 60.0, 61.0, 60.0, 61.0, 60.0, 60.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 78.0, 78.0, 79.0, 79.0, 81.0, 83.0, 80.0, 80.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 125.0, 130.0, 121.0, 132.0, 132.0, 122.0, 130.0, 155.0, 141.0], "value": 132.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 168.0, 165.0, 163.0, 164.0, 163.0, 162.0, 162.0, 164.0, 165.0], "value": 164.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 64.0, 65.0, 64.0, 64.0, 64.0, 67.0, 63.0, 65.0], "value": 64.5, "unit": "score"}], "name": "kraken", "value": 1484.3999999999999, "alertThreshold": 2.0}]} 13:12:24 INFO - Return code: 0 13:12:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:12:24 INFO - # TBPL SUCCESS # 13:12:24 INFO - Running post-action listener: _resource_record_post_action 13:12:24 INFO - [mozharness: 2016-09-27 20:12:24.727232Z] Finished run-tests step (success) 13:12:24 INFO - Running post-run listener: _resource_record_post_run 13:12:24 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 399749120; Read time: 8; Write time: 716716 13:12:24 INFO - TinderboxPrint: CPU usage
13.0% 13:12:24 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 13:12:24 INFO - TinderboxPrint: I/O write bytes / time
399,749,120 / 716,716 13:12:24 INFO - TinderboxPrint: CPU idle
8,310.0 (86.9%) 13:12:24 INFO - TinderboxPrint: CPU user
1,194.4 (12.5%) 13:12:24 INFO - TinderboxPrint: Swap in / out
0 / 0 13:12:24 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 111509504; Read time: 0; Write time: 200512 13:12:24 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 288239616; Read time: 0; Write time: 516204 13:12:25 INFO - Running post-run listener: _upload_blobber_files 13:12:25 INFO - Blob upload gear active. 13:12:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:12:25 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 13:12:25 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:12:25 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:12:25 INFO - (blobuploader) - INFO - Open directory for files ... 13:12:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:12:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:12:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:12:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:12:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:12:30 INFO - (blobuploader) - INFO - Done attempting. 13:12:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:12:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:12:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:12:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:12:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:12:31 INFO - (blobuploader) - INFO - Done attempting. 13:12:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:12:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:12:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:12:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:12:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:12:33 INFO - (blobuploader) - INFO - Done attempting. 13:12:33 INFO - (blobuploader) - INFO - Iteration through files over. 13:12:33 INFO - Return code: 0 13:12:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:12:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:12:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6439038e37f4a0a7f51cd12c712692cdb8596bb415991c6d8ae80acc61a9df4e8c8096c48c77f3b21962bb510ca395df396d1d5bf48d4abf34633f88c13c121c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a247c294e556096a3eaef071da70f7f65f01d54015323075a863a9ea9b7dd9ded6584d4833b7d123475517e673bea606ce5e943c9598b7a51b640dae06de5dae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b3e094e079aacdb36128acda3c30a75574f4fb818896dab709bd1f1bd72387f2cdb9e1706773d37d515d0594ba1058e85447f8315e1646fbcd212db2645aeae5"} 13:12:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:12:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:12:33 INFO - Contents: 13:12:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6439038e37f4a0a7f51cd12c712692cdb8596bb415991c6d8ae80acc61a9df4e8c8096c48c77f3b21962bb510ca395df396d1d5bf48d4abf34633f88c13c121c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a247c294e556096a3eaef071da70f7f65f01d54015323075a863a9ea9b7dd9ded6584d4833b7d123475517e673bea606ce5e943c9598b7a51b640dae06de5dae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b3e094e079aacdb36128acda3c30a75574f4fb818896dab709bd1f1bd72387f2cdb9e1706773d37d515d0594ba1058e85447f8315e1646fbcd212db2645aeae5"} 13:12:33 INFO - Running post-run listener: copy_logs_to_upload_dir 13:12:33 INFO - Copying logs to upload dir... 13:12:33 INFO - mkdir: /builds/slave/test/build/upload/logs 13:12:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.270559 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-09-27 13:12:33.143234) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 13:12:33.147135) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1475005907.748847-207031740 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/sha512/6439038e37f4a0a7f51cd12c712692cdb8596bb415991c6d8ae80acc61a9df4e8c8096c48c77f3b21962bb510ca395df396d1d5bf48d4abf34633f88c13c121c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a247c294e556096a3eaef071da70f7f65f01d54015323075a863a9ea9b7dd9ded6584d4833b7d123475517e673bea606ce5e943c9598b7a51b640dae06de5dae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b3e094e079aacdb36128acda3c30a75574f4fb818896dab709bd1f1bd72387f2cdb9e1706773d37d515d0594ba1058e85447f8315e1646fbcd212db2645aeae5"} build_url:https://queue.taskcluster.net/v1/task/di3Cbpa_Q76c--xlwxsgfA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011294 build_url: 'https://queue.taskcluster.net/v1/task/di3Cbpa_Q76c--xlwxsgfA/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/sha512/6439038e37f4a0a7f51cd12c712692cdb8596bb415991c6d8ae80acc61a9df4e8c8096c48c77f3b21962bb510ca395df396d1d5bf48d4abf34633f88c13c121c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a247c294e556096a3eaef071da70f7f65f01d54015323075a863a9ea9b7dd9ded6584d4833b7d123475517e673bea606ce5e943c9598b7a51b640dae06de5dae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b3e094e079aacdb36128acda3c30a75574f4fb818896dab709bd1f1bd72387f2cdb9e1706773d37d515d0594ba1058e85447f8315e1646fbcd212db2645aeae5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 13:12:33.176937) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 13:12:33.177651) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1475005907.748847-207031740 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 13:12:33.259787) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 13:12:33.260130) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 13:12:33.260447) ========= ========= Total master_lag: 0.19 =========