builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-035 starttime: 1474643349.36 results: success (0) buildid: 20160923072200 builduid: ba1d732cd7e744b5a76c252745767b50 revision: 55a83c8bfcbc3dd8b1d324883c1e68fd6d5bddf8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 08:09:09.361864) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 08:09:09.362232) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 08:09:09.362509) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 08:09:09.386054) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 08:09:09.386310) ========= 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=ed14279e38b05397cf4aa391000001a4-1474641296.502216-668379515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-23 08:09:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 103M=0s 2016-09-23 08:09:09 (103 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104938 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 08:09:09.504758) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 08:09:09.505049) ========= 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=ed14279e38b05397cf4aa391000001a4-1474641296.502216-668379515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020957 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 08:09:09.555424) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-23 08:09:09.555776) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 55a83c8bfcbc3dd8b1d324883c1e68fd6d5bddf8 --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 55a83c8bfcbc3dd8b1d324883c1e68fd6d5bddf8 --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=ed14279e38b05397cf4aa391000001a4-1474641296.502216-668379515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-23 08:09:09,875 truncating revision to first 12 chars 2016-09-23 08:09:09,875 Setting DEBUG logging. 2016-09-23 08:09:09,875 attempt 1/10 2016-09-23 08:09:09,875 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/55a83c8bfcbc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-23 08:09:10,683 unpacking tar archive at: fx-team-55a83c8bfcbc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.244130 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-23 08:09:10.814848) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 08:09:10.815200) ========= script_repo_revision: 55a83c8bfcbc3dd8b1d324883c1e68fd6d5bddf8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 08:09:10.815622) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 08:09:10.815982) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 08:09:10.825949) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-09-23 08:09:10.826365) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1474641296.502216-668379515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:09:11 INFO - MultiFileLogger online at 20160923 08:09:11 in /builds/slave/test 08:09:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:09:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:09:11 INFO - {'append_to_log': False, 08:09:11 INFO - 'base_work_dir': '/builds/slave/test', 08:09:11 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:09:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:09:11 INFO - 'branch': 'Fx-Team-Non-PGO', 08:09:11 INFO - 'buildbot_json_path': 'buildprops.json', 08:09:11 INFO - 'config_files': ('talos/linux_config.py',), 08:09:11 INFO - 'default_actions': ('clobber', 08:09:11 INFO - 'read-buildbot-config', 08:09:11 INFO - 'download-and-extract', 08:09:11 INFO - 'populate-webroot', 08:09:11 INFO - 'create-virtualenv', 08:09:11 INFO - 'install', 08:09:11 INFO - 'run-tests'), 08:09:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:09:11 INFO - 'download_minidump_stackwalk': True, 08:09:11 INFO - 'download_symbols': 'ondemand', 08:09:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:09:11 INFO - 'tooltool.py': '/tools/tooltool.py', 08:09:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:09:11 INFO - '/tools/misc-python/virtualenv.py')}, 08:09:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:09:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:09:11 INFO - 'installer_path': 'installer.exe', 08:09:11 INFO - 'log_level': 'info', 08:09:11 INFO - 'log_name': 'talos', 08:09:11 INFO - 'log_to_console': True, 08:09:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:09:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:09:11 INFO - 'opt_config_files': (), 08:09:11 INFO - 'pip_index': False, 08:09:11 INFO - 'sps_profile': False, 08:09:11 INFO - 'sps_profile_interval': 0, 08:09:11 INFO - 'suite': 'dromaeojs', 08:09:11 INFO - 'system_bits': '32', 08:09:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:09:11 INFO - 'title': 'talos-linux64-ix-035', 08:09:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:09:11 INFO - 'use_talos_json': True, 08:09:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:09:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:09:11 INFO - 'work_dir': 'build'} 08:09:11 INFO - [mozharness: 2016-09-23 15:09:11.238161Z] Running clobber step. 08:09:11 INFO - Running pre-action listener: _resource_record_pre_action 08:09:11 INFO - Running main action method: clobber 08:09:11 INFO - rmtree: /builds/slave/test/build 08:09:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:09:11 INFO - Running post-action listener: _resource_record_post_action 08:09:11 INFO - [mozharness: 2016-09-23 15:09:11.692026Z] Finished clobber step (success) 08:09:11 INFO - [mozharness: 2016-09-23 15:09:11.692129Z] Running read-buildbot-config step. 08:09:11 INFO - Running pre-action listener: _resource_record_pre_action 08:09:11 INFO - Running main action method: read_buildbot_config 08:09:11 INFO - Using buildbot properties: 08:09:11 INFO - { 08:09:11 INFO - "project": "", 08:09:11 INFO - "product": "firefox", 08:09:11 INFO - "script_repo_revision": "production", 08:09:11 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:09:11 INFO - "repository": "", 08:09:11 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:09:11 INFO - "buildid": "20160923072200", 08:09:11 INFO - "pgo_build": "False", 08:09:11 INFO - "basedir": "/builds/slave/test", 08:09:11 INFO - "buildnumber": 3349, 08:09:11 INFO - "slavename": "talos-linux64-ix-035", 08:09:11 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:09:11 INFO - "platform": "ubuntu64_hw", 08:09:11 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:09:11 INFO - "branch": "fx-team", 08:09:11 INFO - "repo_path": "integration/fx-team", 08:09:11 INFO - "revision": "55a83c8bfcbc3dd8b1d324883c1e68fd6d5bddf8", 08:09:11 INFO - "stage_platform": "linux64", 08:09:11 INFO - "builduid": "ba1d732cd7e744b5a76c252745767b50", 08:09:11 INFO - "slavebuilddir": "test" 08:09:11 INFO - } 08:09:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/KUUmQOFvRpe85Vs5DR4wTA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 08:09:11 INFO - Running post-action listener: _resource_record_post_action 08:09:11 INFO - [mozharness: 2016-09-23 15:09:11.694898Z] Finished read-buildbot-config step (success) 08:09:11 INFO - [mozharness: 2016-09-23 15:09:11.694987Z] Running download-and-extract step. 08:09:11 INFO - Running pre-action listener: _resource_record_pre_action 08:09:11 INFO - Running main action method: download_and_extract 08:09:11 INFO - mkdir: /builds/slave/test/build/tests 08:09:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:11 INFO - trying https://queue.taskcluster.net/v1/task/KUUmQOFvRpe85Vs5DR4wTA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:09:11 INFO - Downloading https://queue.taskcluster.net/v1/task/KUUmQOFvRpe85Vs5DR4wTA/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 08:09:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KUUmQOFvRpe85Vs5DR4wTA/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 08:09:12 INFO - Downloaded 1361 bytes. 08:09:12 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:09:12 INFO - Using the following test package requirements: 08:09:12 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 08:09:12 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:09:12 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:09:12 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:12 INFO - u'jsshell-linux-x86_64.zip'], 08:09:12 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:09:12 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 08:09:12 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:09:12 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:09:12 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:09:12 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:09:12 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:09:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KUUmQOFvRpe85Vs5DR4wTA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 08:09:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KUUmQOFvRpe85Vs5DR4wTA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:09:12 INFO - Fetch https://queue.taskcluster.net/v1/task/KUUmQOFvRpe85Vs5DR4wTA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:09:12 INFO - Expected file size: 20377253 08:09:17 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 08:09:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KUUmQOFvRpe85Vs5DR4wTA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 08:09:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KUUmQOFvRpe85Vs5DR4wTA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:09:17 INFO - Fetch https://queue.taskcluster.net/v1/task/KUUmQOFvRpe85Vs5DR4wTA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:09:18 INFO - Expected file size: 20377253 08:09:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KUUmQOFvRpe85Vs5DR4wTA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 08:09:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KUUmQOFvRpe85Vs5DR4wTA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:09:23 INFO - Fetch https://queue.taskcluster.net/v1/task/KUUmQOFvRpe85Vs5DR4wTA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 08:09:23 INFO - Expected file size: 14414059 08:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:25 INFO - trying https://queue.taskcluster.net/v1/task/KUUmQOFvRpe85Vs5DR4wTA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:09:25 INFO - Downloading https://queue.taskcluster.net/v1/task/KUUmQOFvRpe85Vs5DR4wTA/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 08:09:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KUUmQOFvRpe85Vs5DR4wTA/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 08:09:27 INFO - Downloaded 55729592 bytes. 08:09:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KUUmQOFvRpe85Vs5DR4wTA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:09:27 INFO - mkdir: /builds/slave/test/properties 08:09:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:09:27 INFO - Writing to file /builds/slave/test/properties/build_url 08:09:27 INFO - Contents: 08:09:27 INFO - build_url:https://queue.taskcluster.net/v1/task/KUUmQOFvRpe85Vs5DR4wTA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:09:28 INFO - Running post-action listener: _resource_record_post_action 08:09:28 INFO - Running post-action listener: set_extra_try_arguments 08:09:28 INFO - [mozharness: 2016-09-23 15:09:28.254616Z] Finished download-and-extract step (success) 08:09:28 INFO - [mozharness: 2016-09-23 15:09:28.254845Z] Running populate-webroot step. 08:09:28 INFO - Running pre-action listener: _resource_record_pre_action 08:09:28 INFO - Running main action method: populate_webroot 08:09:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:09:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:09:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:09:28 INFO - '--tppagecycles', 08:09:28 INFO - '7'], 08:09:28 INFO - 'tests': ['tsvgm']}}, 08:09:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:09:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:09:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:09:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:09:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:09:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:09:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:28 INFO - 'talos_options': ['--disable-e10s'], 08:09:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:09:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:09:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:28 INFO - 'talos_options': ['--disable-e10s'], 08:09:28 INFO - 'tests': ['damp', 'tps']}, 08:09:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:28 INFO - 'tests': ['damp', 'tps']}, 08:09:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:09:28 INFO - 'tests': ['dromaeo_dom']}, 08:09:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:09:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:09:28 INFO - 'tests': ['basic_compositor_video']}, 08:09:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:09:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:09:28 INFO - 'tests': ['a11yr', 08:09:28 INFO - 'ts_paint', 08:09:28 INFO - 'tpaint', 08:09:28 INFO - 'sessionrestore', 08:09:28 INFO - 'sessionrestore_no_auto_restore', 08:09:28 INFO - 'tabpaint']}, 08:09:28 INFO - 'other-e10s': {'tests': ['a11yr', 08:09:28 INFO - 'ts_paint', 08:09:28 INFO - 'tpaint', 08:09:28 INFO - 'sessionrestore', 08:09:28 INFO - 'sessionrestore_no_auto_restore', 08:09:28 INFO - 'tabpaint']}, 08:09:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:09:28 INFO - 'ts_paint', 08:09:28 INFO - 'tpaint', 08:09:28 INFO - 'sessionrestore', 08:09:28 INFO - 'sessionrestore_no_auto_restore', 08:09:28 INFO - 'tabpaint']}, 08:09:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:09:28 INFO - 'ts_paint', 08:09:28 INFO - 'tpaint', 08:09:28 INFO - 'sessionrestore', 08:09:28 INFO - 'sessionrestore_no_auto_restore', 08:09:28 INFO - 'tabpaint']}, 08:09:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:09:28 INFO - 'tests': ['a11yr', 08:09:28 INFO - 'ts_paint', 08:09:28 INFO - 'tpaint', 08:09:28 INFO - 'sessionrestore', 08:09:28 INFO - 'sessionrestore_no_auto_restore', 08:09:28 INFO - 'tabpaint']}, 08:09:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:09:28 INFO - 'tests': ['a11yr', 08:09:28 INFO - 'ts_paint', 08:09:28 INFO - 'tpaint', 08:09:28 INFO - 'sessionrestore', 08:09:28 INFO - 'sessionrestore_no_auto_restore', 08:09:28 INFO - 'tabpaint']}, 08:09:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:09:28 INFO - 'tests': ['tsvgx', 08:09:28 INFO - 'tsvgr_opacity', 08:09:28 INFO - 'tart', 08:09:28 INFO - 'tscrollx', 08:09:28 INFO - 'cart']}, 08:09:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:09:28 INFO - 'tsvgr_opacity', 08:09:28 INFO - 'tart', 08:09:28 INFO - 'tscrollx', 08:09:28 INFO - 'cart']}, 08:09:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:28 INFO - 'talos_options': ['--disable-e10s'], 08:09:28 INFO - 'tests': ['tp5o']}, 08:09:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:28 INFO - 'tests': ['tp5o']}, 08:09:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:28 INFO - 'talos_options': ['--disable-e10s', 08:09:28 INFO - '--xperf_path', 08:09:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:09:28 INFO - 'tests': ['tp5n']}, 08:09:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:28 INFO - 'talos_options': ['--xperf_path', 08:09:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:09:28 INFO - 'tests': ['tp5n']}}, 08:09:28 INFO - 'talos.zip': {'path': '', 08:09:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:09:28 INFO - Running post-action listener: _resource_record_post_action 08:09:28 INFO - [mozharness: 2016-09-23 15:09:28.274971Z] Finished populate-webroot step (success) 08:09:28 INFO - [mozharness: 2016-09-23 15:09:28.275060Z] Running create-virtualenv step. 08:09:28 INFO - Running pre-action listener: _resource_record_pre_action 08:09:28 INFO - Running main action method: create_virtualenv 08:09:28 INFO - Creating virtualenv /builds/slave/test/build/venv 08:09:28 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:09:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:09:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:09:28 INFO - Using real prefix '/usr' 08:09:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:09:28 INFO - Installing distribute.............................................................................................................................................................................................done. 08:09:30 INFO - Installing pip.................done. 08:09:30 INFO - Return code: 0 08:09:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:09:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:30 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 0x7f54dd938f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a2f60>, '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 0x25a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a41d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1474641296.502216-668379515', '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 08:09:30 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 08:09:30 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 08:09:30 INFO - Using env: {'DISPLAY': ':0', 08:09:30 INFO - 'HOME': '/home/cltbld', 08:09:30 INFO - 'LANG': 'en_US.UTF-8', 08:09:30 INFO - 'LANGUAGE': 'en_US:en', 08:09:30 INFO - 'LOGNAME': 'cltbld', 08:09:30 INFO - 'MAIL': '/var/mail/cltbld', 08:09:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:30 INFO - 'MOZ_NO_REMOTE': '1', 08:09:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:30 INFO - 'NO_EM_RESTART': '1', 08:09:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:30 INFO - 'PWD': '/builds/slave/test', 08:09:30 INFO - 'SHELL': '/bin/bash', 08:09:30 INFO - 'SHLVL': '1', 08:09:30 INFO - 'TERM': 'linux', 08:09:30 INFO - 'TMOUT': '86400', 08:09:30 INFO - 'USER': 'cltbld', 08:09:30 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1474641296.502216-668379515', 08:09:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:30 INFO - '_': '/tools/buildbot/bin/python'} 08:09:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:31 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:09:31 INFO - Cleaning up... 08:09:31 INFO - Return code: 0 08:09:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f54dd938f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a2f60>, '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 0x25a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a41d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1474641296.502216-668379515', '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 08:09:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:09:31 INFO - Using env: {'DISPLAY': ':0', 08:09:31 INFO - 'HOME': '/home/cltbld', 08:09:31 INFO - 'LANG': 'en_US.UTF-8', 08:09:31 INFO - 'LANGUAGE': 'en_US:en', 08:09:31 INFO - 'LOGNAME': 'cltbld', 08:09:31 INFO - 'MAIL': '/var/mail/cltbld', 08:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:31 INFO - 'MOZ_NO_REMOTE': '1', 08:09:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:31 INFO - 'NO_EM_RESTART': '1', 08:09:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:31 INFO - 'PWD': '/builds/slave/test', 08:09:31 INFO - 'SHELL': '/bin/bash', 08:09:31 INFO - 'SHLVL': '1', 08:09:31 INFO - 'TERM': 'linux', 08:09:31 INFO - 'TMOUT': '86400', 08:09:31 INFO - 'USER': 'cltbld', 08:09:31 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1474641296.502216-668379515', 08:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:31 INFO - '_': '/tools/buildbot/bin/python'} 08:09:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:31 INFO - Downloading/unpacking psutil>=3.1.1 08:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:09:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:09:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:09:33 INFO - Installing collected packages: psutil 08:09:33 INFO - Running setup.py install for psutil 08:09:33 INFO - building 'psutil._psutil_linux' extension 08:09:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:09:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:09:33 INFO - building 'psutil._psutil_posix' extension 08:09:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:09:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:09:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:09:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:09:33 INFO - Successfully installed psutil 08:09:33 INFO - Cleaning up... 08:09:33 INFO - Return code: 0 08:09:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:33 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 0x7f54dd938f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a2f60>, '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 0x25a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a41d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1474641296.502216-668379515', '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 08:09:33 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 08:09:33 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 08:09:33 INFO - Using env: {'DISPLAY': ':0', 08:09:33 INFO - 'HOME': '/home/cltbld', 08:09:33 INFO - 'LANG': 'en_US.UTF-8', 08:09:33 INFO - 'LANGUAGE': 'en_US:en', 08:09:33 INFO - 'LOGNAME': 'cltbld', 08:09:33 INFO - 'MAIL': '/var/mail/cltbld', 08:09:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:33 INFO - 'MOZ_NO_REMOTE': '1', 08:09:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:33 INFO - 'NO_EM_RESTART': '1', 08:09:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:33 INFO - 'PWD': '/builds/slave/test', 08:09:33 INFO - 'SHELL': '/bin/bash', 08:09:33 INFO - 'SHLVL': '1', 08:09:33 INFO - 'TERM': 'linux', 08:09:33 INFO - 'TMOUT': '86400', 08:09:33 INFO - 'USER': 'cltbld', 08:09:33 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1474641296.502216-668379515', 08:09:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:33 INFO - '_': '/tools/buildbot/bin/python'} 08:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:09:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:09:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:09:36 INFO - Installing collected packages: mozsystemmonitor 08:09:36 INFO - Running setup.py install for mozsystemmonitor 08:09:36 INFO - Successfully installed mozsystemmonitor 08:09:36 INFO - Cleaning up... 08:09:36 INFO - Return code: 0 08:09:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f54dd938f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a2f60>, '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 0x25a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a41d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1474641296.502216-668379515', '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 08:09:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:09:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:09:36 INFO - Using env: {'DISPLAY': ':0', 08:09:36 INFO - 'HOME': '/home/cltbld', 08:09:36 INFO - 'LANG': 'en_US.UTF-8', 08:09:36 INFO - 'LANGUAGE': 'en_US:en', 08:09:36 INFO - 'LOGNAME': 'cltbld', 08:09:36 INFO - 'MAIL': '/var/mail/cltbld', 08:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:36 INFO - 'MOZ_NO_REMOTE': '1', 08:09:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:36 INFO - 'NO_EM_RESTART': '1', 08:09:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:36 INFO - 'PWD': '/builds/slave/test', 08:09:36 INFO - 'SHELL': '/bin/bash', 08:09:36 INFO - 'SHLVL': '1', 08:09:36 INFO - 'TERM': 'linux', 08:09:36 INFO - 'TMOUT': '86400', 08:09:36 INFO - 'USER': 'cltbld', 08:09:36 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1474641296.502216-668379515', 08:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:36 INFO - '_': '/tools/buildbot/bin/python'} 08:09:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:36 INFO - Downloading/unpacking jsonschema==2.5.1 08:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:09:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:38 INFO - Downloading functools32-3.2.3-2.tar.gz 08:09:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:09:38 INFO - warning: no files found matching '*.txt' 08:09:38 INFO - no previously-included directories found matching 'build' 08:09:38 INFO - no previously-included directories found matching 'dist' 08:09:38 INFO - no previously-included directories found matching '.git*' 08:09:38 INFO - Installing collected packages: jsonschema, functools32 08:09:38 INFO - Running setup.py install for functools32 08:09:38 INFO - warning: no files found matching '*.txt' 08:09:38 INFO - no previously-included directories found matching 'build' 08:09:38 INFO - no previously-included directories found matching 'dist' 08:09:38 INFO - no previously-included directories found matching '.git*' 08:09:38 INFO - Successfully installed jsonschema functools32 08:09:38 INFO - Cleaning up... 08:09:38 INFO - Return code: 0 08:09:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:09:38 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')]} 08:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:38 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')]} 08:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:38 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 0x7f54dd938f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a2f60>, '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 0x25a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a41d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1474641296.502216-668379515', '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 08:09:38 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 08:09:38 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 08:09:38 INFO - Using env: {'DISPLAY': ':0', 08:09:38 INFO - 'HOME': '/home/cltbld', 08:09:38 INFO - 'LANG': 'en_US.UTF-8', 08:09:38 INFO - 'LANGUAGE': 'en_US:en', 08:09:38 INFO - 'LOGNAME': 'cltbld', 08:09:38 INFO - 'MAIL': '/var/mail/cltbld', 08:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:38 INFO - 'MOZ_NO_REMOTE': '1', 08:09:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:38 INFO - 'NO_EM_RESTART': '1', 08:09:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:38 INFO - 'PWD': '/builds/slave/test', 08:09:38 INFO - 'SHELL': '/bin/bash', 08:09:38 INFO - 'SHLVL': '1', 08:09:38 INFO - 'TERM': 'linux', 08:09:38 INFO - 'TMOUT': '86400', 08:09:38 INFO - 'USER': 'cltbld', 08:09:38 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1474641296.502216-668379515', 08:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:38 INFO - '_': '/tools/buildbot/bin/python'} 08:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:09:38 INFO - Cleaning up... 08:09:38 INFO - Return code: 0 08:09:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:09:38 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')]} 08:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:38 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')]} 08:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:38 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 0x7f54dd938f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a2f60>, '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 0x25a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a41d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1474641296.502216-668379515', '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 08:09:38 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 08:09:38 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 08:09:38 INFO - Using env: {'DISPLAY': ':0', 08:09:38 INFO - 'HOME': '/home/cltbld', 08:09:38 INFO - 'LANG': 'en_US.UTF-8', 08:09:38 INFO - 'LANGUAGE': 'en_US:en', 08:09:38 INFO - 'LOGNAME': 'cltbld', 08:09:38 INFO - 'MAIL': '/var/mail/cltbld', 08:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:38 INFO - 'MOZ_NO_REMOTE': '1', 08:09:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:38 INFO - 'NO_EM_RESTART': '1', 08:09:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:38 INFO - 'PWD': '/builds/slave/test', 08:09:38 INFO - 'SHELL': '/bin/bash', 08:09:38 INFO - 'SHLVL': '1', 08:09:38 INFO - 'TERM': 'linux', 08:09:38 INFO - 'TMOUT': '86400', 08:09:38 INFO - 'USER': 'cltbld', 08:09:38 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1474641296.502216-668379515', 08:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:38 INFO - '_': '/tools/buildbot/bin/python'} 08:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:39 INFO - Downloading/unpacking blobuploader==1.2.4 08:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:41 INFO - Downloading blobuploader-1.2.4.tar.gz 08:09:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:09:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:09:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:41 INFO - Downloading docopt-0.6.1.tar.gz 08:09:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:09:41 INFO - Installing collected packages: blobuploader, requests, docopt 08:09:41 INFO - Running setup.py install for blobuploader 08:09:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:09:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:09:41 INFO - Running setup.py install for requests 08:09:42 INFO - Running setup.py install for docopt 08:09:42 INFO - Successfully installed blobuploader requests docopt 08:09:42 INFO - Cleaning up... 08:09:42 INFO - Return code: 0 08:09:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f54dd938f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a2f60>, '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 0x25a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a41d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1474641296.502216-668379515', '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 08:09:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:09:42 INFO - Using env: {'DISPLAY': ':0', 08:09:42 INFO - 'HOME': '/home/cltbld', 08:09:42 INFO - 'LANG': 'en_US.UTF-8', 08:09:42 INFO - 'LANGUAGE': 'en_US:en', 08:09:42 INFO - 'LOGNAME': 'cltbld', 08:09:42 INFO - 'MAIL': '/var/mail/cltbld', 08:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:42 INFO - 'MOZ_NO_REMOTE': '1', 08:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:42 INFO - 'NO_EM_RESTART': '1', 08:09:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:42 INFO - 'PWD': '/builds/slave/test', 08:09:42 INFO - 'SHELL': '/bin/bash', 08:09:42 INFO - 'SHLVL': '1', 08:09:42 INFO - 'TERM': 'linux', 08:09:42 INFO - 'TMOUT': '86400', 08:09:42 INFO - 'USER': 'cltbld', 08:09:42 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1474641296.502216-668379515', 08:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:42 INFO - '_': '/tools/buildbot/bin/python'} 08:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:09:42 INFO - Running setup.py (path:/tmp/pip-Ppqq2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:09:42 INFO - Running setup.py (path:/tmp/pip-kHLs2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:09:42 INFO - Running setup.py (path:/tmp/pip-_1AtJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:09:42 INFO - Running setup.py (path:/tmp/pip-MxMhK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:09:42 INFO - Running setup.py (path:/tmp/pip-QUj773-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:09:43 INFO - Running setup.py (path:/tmp/pip-uNRXqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:09:43 INFO - Running setup.py (path:/tmp/pip-JSSLgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:09:43 INFO - Running setup.py (path:/tmp/pip-drP5co-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:09:43 INFO - Running setup.py (path:/tmp/pip-ZSoJ1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:09:43 INFO - Running setup.py (path:/tmp/pip-qlsYJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:09:43 INFO - Running setup.py (path:/tmp/pip-eosqGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:09:43 INFO - Running setup.py (path:/tmp/pip-SZnJvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:09:43 INFO - Running setup.py (path:/tmp/pip-4LRoku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:09:43 INFO - Running setup.py (path:/tmp/pip-z0IFCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:43 INFO - Running setup.py (path:/tmp/pip-mREVq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:09:43 INFO - Running setup.py (path:/tmp/pip-0fZ_Cz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:09:43 INFO - Running setup.py (path:/tmp/pip-qOMFAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:09:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:09:43 INFO - Running setup.py install for manifestparser 08:09:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:09:43 INFO - Running setup.py install for mozcrash 08:09:44 INFO - Running setup.py install for mozdebug 08:09:44 INFO - Running setup.py install for mozdevice 08:09:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:09:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:09:44 INFO - Running setup.py install for mozfile 08:09:44 INFO - Running setup.py install for mozhttpd 08:09:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:09:44 INFO - Running setup.py install for mozinfo 08:09:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:09:44 INFO - Running setup.py install for mozInstall 08:09:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:09:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:09:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:09:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:09:44 INFO - Running setup.py install for mozleak 08:09:44 INFO - Running setup.py install for mozlog 08:09:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:09:44 INFO - Running setup.py install for moznetwork 08:09:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:09:45 INFO - Running setup.py install for mozprocess 08:09:45 INFO - Running setup.py install for mozprofile 08:09:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:09:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:09:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:09:45 INFO - Running setup.py install for mozrunner 08:09:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:09:45 INFO - Running setup.py install for mozscreenshot 08:09:45 INFO - Running setup.py install for moztest 08:09:45 INFO - Running setup.py install for mozversion 08:09:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:09:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:09:45 INFO - Cleaning up... 08:09:45 INFO - Return code: 0 08:09:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:45 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')]} 08:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:45 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')]} 08:09:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:45 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 0x7f54dd938f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a2f60>, '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 0x25a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a41d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1474641296.502216-668379515', '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 08:09:45 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 08:09:45 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 08:09:45 INFO - Using env: {'DISPLAY': ':0', 08:09:45 INFO - 'HOME': '/home/cltbld', 08:09:45 INFO - 'LANG': 'en_US.UTF-8', 08:09:45 INFO - 'LANGUAGE': 'en_US:en', 08:09:45 INFO - 'LOGNAME': 'cltbld', 08:09:45 INFO - 'MAIL': '/var/mail/cltbld', 08:09:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:45 INFO - 'MOZ_NO_REMOTE': '1', 08:09:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:45 INFO - 'NO_EM_RESTART': '1', 08:09:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:45 INFO - 'PWD': '/builds/slave/test', 08:09:45 INFO - 'SHELL': '/bin/bash', 08:09:45 INFO - 'SHLVL': '1', 08:09:45 INFO - 'TERM': 'linux', 08:09:45 INFO - 'TMOUT': '86400', 08:09:45 INFO - 'USER': 'cltbld', 08:09:45 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1474641296.502216-668379515', 08:09:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:45 INFO - '_': '/tools/buildbot/bin/python'} 08:09:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:09:45 INFO - Running setup.py (path:/tmp/pip-greyGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:09:45 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)) 08:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:09:45 INFO - Running setup.py (path:/tmp/pip-K28UWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:09:46 INFO - Running setup.py (path:/tmp/pip-mpD9Sg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:09:46 INFO - Running setup.py (path:/tmp/pip-FmyA4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:09:46 INFO - Running setup.py (path:/tmp/pip-UBsYvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:09:46 INFO - Running setup.py (path:/tmp/pip-fNVP9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:09:46 INFO - Running setup.py (path:/tmp/pip-InmqFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:09:46 INFO - Running setup.py (path:/tmp/pip-KyF_hl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:09:46 INFO - Running setup.py (path:/tmp/pip-c1J43e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:09:46 INFO - Running setup.py (path:/tmp/pip-H5bFZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:09:46 INFO - Running setup.py (path:/tmp/pip-uL61Kd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:09:46 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)) 08:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:09:46 INFO - Running setup.py (path:/tmp/pip-yPbs0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:09:46 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)) 08:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:09:46 INFO - Running setup.py (path:/tmp/pip-wXayLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:09:46 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)) 08:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:09:46 INFO - Running setup.py (path:/tmp/pip-iitsJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:09:46 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)) 08:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:46 INFO - Running setup.py (path:/tmp/pip-llrJHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:46 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)) 08:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:09:46 INFO - Running setup.py (path:/tmp/pip-rO3mkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:09:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:09:47 INFO - Running setup.py (path:/tmp/pip-y8OZMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:09:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:09:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:09:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:09:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:09:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:09:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:09:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:49 INFO - Downloading blessings-1.6.tar.gz 08:09:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:09:49 INFO - Installing collected packages: blessings 08:09:49 INFO - Running setup.py install for blessings 08:09:49 INFO - Successfully installed blessings 08:09:49 INFO - Cleaning up... 08:09:49 INFO - Return code: 0 08:09:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:09:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:09:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:09:49 INFO - Reading from file tmpfile_stdout 08:09:49 INFO - Current package versions: 08:09:49 INFO - argparse == 1.2.1 08:09:49 INFO - blessings == 1.6 08:09:49 INFO - blobuploader == 1.2.4 08:09:49 INFO - docopt == 0.6.1 08:09:49 INFO - functools32 == 3.2.3-2 08:09:49 INFO - jsonschema == 2.5.1 08:09:49 INFO - manifestparser == 1.1 08:09:49 INFO - mozInstall == 1.12 08:09:49 INFO - mozcrash == 0.17 08:09:49 INFO - mozdebug == 0.1 08:09:49 INFO - mozdevice == 0.48 08:09:49 INFO - mozfile == 1.2 08:09:49 INFO - mozhttpd == 0.7 08:09:49 INFO - mozinfo == 0.9 08:09:49 INFO - mozleak == 0.1 08:09:49 INFO - mozlog == 3.4 08:09:49 INFO - moznetwork == 0.27 08:09:49 INFO - mozprocess == 0.23 08:09:49 INFO - mozprofile == 0.28 08:09:49 INFO - mozrunner == 6.12 08:09:49 INFO - mozscreenshot == 0.1 08:09:49 INFO - mozsystemmonitor == 0.3 08:09:49 INFO - moztest == 0.7 08:09:49 INFO - mozversion == 1.4 08:09:49 INFO - psutil == 3.1.1 08:09:49 INFO - requests == 1.2.3 08:09:49 INFO - wsgiref == 0.1.2 08:09:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f54dd938f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a2f60>, '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 0x25a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a41d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1474641296.502216-668379515', '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 08:09:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:09:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:09:49 INFO - Using env: {'DISPLAY': ':0', 08:09:49 INFO - 'HOME': '/home/cltbld', 08:09:49 INFO - 'LANG': 'en_US.UTF-8', 08:09:49 INFO - 'LANGUAGE': 'en_US:en', 08:09:49 INFO - 'LOGNAME': 'cltbld', 08:09:49 INFO - 'MAIL': '/var/mail/cltbld', 08:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:49 INFO - 'MOZ_NO_REMOTE': '1', 08:09:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:49 INFO - 'NO_EM_RESTART': '1', 08:09:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:49 INFO - 'PWD': '/builds/slave/test', 08:09:49 INFO - 'SHELL': '/bin/bash', 08:09:49 INFO - 'SHLVL': '1', 08:09:49 INFO - 'TERM': 'linux', 08:09:49 INFO - 'TMOUT': '86400', 08:09:49 INFO - 'USER': 'cltbld', 08:09:49 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1474641296.502216-668379515', 08:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:49 INFO - '_': '/tools/buildbot/bin/python'} 08:09:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:49 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)) 08:09:49 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)) 08:09:49 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)) 08:09:49 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)) 08:09:49 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)) 08:09:49 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)) 08:09:49 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)) 08:09:49 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)) 08:09:49 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)) 08:09:49 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)) 08:09:49 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)) 08:09:49 INFO - Cleaning up... 08:09:49 INFO - Return code: 0 08:09:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:49 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 0x7f54dd938f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a2f60>, '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 0x25a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a41d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1474641296.502216-668379515', '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 08:09:49 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 08:09:49 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 08:09:49 INFO - Using env: {'DISPLAY': ':0', 08:09:49 INFO - 'HOME': '/home/cltbld', 08:09:49 INFO - 'LANG': 'en_US.UTF-8', 08:09:49 INFO - 'LANGUAGE': 'en_US:en', 08:09:49 INFO - 'LOGNAME': 'cltbld', 08:09:49 INFO - 'MAIL': '/var/mail/cltbld', 08:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:49 INFO - 'MOZ_NO_REMOTE': '1', 08:09:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:49 INFO - 'NO_EM_RESTART': '1', 08:09:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:49 INFO - 'PWD': '/builds/slave/test', 08:09:49 INFO - 'SHELL': '/bin/bash', 08:09:49 INFO - 'SHLVL': '1', 08:09:49 INFO - 'TERM': 'linux', 08:09:49 INFO - 'TMOUT': '86400', 08:09:49 INFO - 'USER': 'cltbld', 08:09:49 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1474641296.502216-668379515', 08:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:49 INFO - '_': '/tools/buildbot/bin/python'} 08:09:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:09:49 INFO - Cleaning up... 08:09:49 INFO - Return code: 0 08:09:49 INFO - Running post-action listener: _resource_record_post_action 08:09:49 INFO - Running post-action listener: _start_resource_monitoring 08:09:49 INFO - Starting resource monitoring. 08:09:49 INFO - [mozharness: 2016-09-23 15:09:49.979335Z] Finished create-virtualenv step (success) 08:09:49 INFO - [mozharness: 2016-09-23 15:09:49.979844Z] Running install step. 08:09:49 INFO - Running pre-action listener: _resource_record_pre_action 08:09:49 INFO - Running main action method: install 08:09:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:09:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:09:50 INFO - Reading from file tmpfile_stdout 08:09:50 INFO - Detecting whether we're running mozinstall >=1.0... 08:09:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:09:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:09:50 INFO - Reading from file tmpfile_stdout 08:09:50 INFO - Output received: 08:09:50 INFO - Usage: mozinstall [options] installer 08:09:50 INFO - Options: 08:09:50 INFO - -h, --help show this help message and exit 08:09:50 INFO - -d DEST, --destination=DEST 08:09:50 INFO - Directory to install application into. [default: 08:09:50 INFO - "/builds/slave/test"] 08:09:50 INFO - --app=APP Application being installed. [default: firefox] 08:09:50 INFO - mkdir: /builds/slave/test/build/application 08:09:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:09:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:10:06 INFO - Reading from file tmpfile_stdout 08:10:06 INFO - Output received: 08:10:06 INFO - /builds/slave/test/build/application/firefox/firefox 08:10:06 INFO - Running post-action listener: _resource_record_post_action 08:10:06 INFO - [mozharness: 2016-09-23 15:10:06.381433Z] Finished install step (success) 08:10:06 INFO - [mozharness: 2016-09-23 15:10:06.381738Z] Running run-tests step. 08:10:06 INFO - Running pre-action listener: _resource_record_pre_action 08:10:06 INFO - Running main action method: run_tests 08:10:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:10:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:10:06 INFO - Python 2.7.3 08:10:06 INFO - Return code: 0 08:10:06 INFO - grabbing minidump binary from tooltool 08:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:06 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a2f60>, '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 0x25a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a41d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:10:06 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:10:06 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:10:06 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:10:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:10:06 INFO - Return code: 0 08:10:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:10:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:10:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:10:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:10:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:10:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KUUmQOFvRpe85Vs5DR4wTA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 08:10:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KUUmQOFvRpe85Vs5DR4wTA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 08:10:06 INFO - Using env: {'DISPLAY': ':0', 08:10:06 INFO - 'HOME': '/home/cltbld', 08:10:06 INFO - 'LANG': 'en_US.UTF-8', 08:10:06 INFO - 'LANGUAGE': 'en_US:en', 08:10:06 INFO - 'LOGNAME': 'cltbld', 08:10:06 INFO - 'MAIL': '/var/mail/cltbld', 08:10:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:10:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:06 INFO - 'MOZ_NO_REMOTE': '1', 08:10:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:10:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:06 INFO - 'NO_EM_RESTART': '1', 08:10:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:06 INFO - 'PWD': '/builds/slave/test', 08:10:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:10:06 INFO - 'SHELL': '/bin/bash', 08:10:06 INFO - 'SHLVL': '1', 08:10:06 INFO - 'TERM': 'linux', 08:10:06 INFO - 'TMOUT': '86400', 08:10:06 INFO - 'USER': 'cltbld', 08:10:06 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1474641296.502216-668379515', 08:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:06 INFO - '_': '/tools/buildbot/bin/python'} 08:10:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KUUmQOFvRpe85Vs5DR4wTA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 08:10:06 INFO - mozversion application_buildid: 20160923072200 08:10:06 INFO - mozversion application_changeset: 55a83c8bfcbc3dd8b1d324883c1e68fd6d5bddf8 08:10:06 INFO - mozversion application_display_name: Nightly 08:10:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:10:06 INFO - mozversion application_name: Firefox 08:10:06 INFO - mozversion application_remotingname: firefox 08:10:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:10:06 INFO - mozversion application_vendor: Mozilla 08:10:06 INFO - mozversion application_version: 52.0a1 08:10:06 INFO - mozversion platform_buildid: 20160923072200 08:10:06 INFO - mozversion platform_changeset: 55a83c8bfcbc3dd8b1d324883c1e68fd6d5bddf8 08:10:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:10:06 INFO - mozversion platform_version: 52.0a1 08:10:06 INFO - using testdate: 1474643406 08:10:06 INFO - actual date: 1474643406 08:10:06 INFO - starting webserver on 'localhost:33103' 08:10:06 INFO - SUITE-START | Running 2 tests 08:10:06 INFO - TEST-START | dromaeo_css 08:10:06 INFO - operating with platform_type : linux_ 08:10:06 INFO - Initialising browser for dromaeo_css test... 08:10:06 INFO - TEST-INFO | started process 30360 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoQQkz_/profile http://localhost:33103/getInfo.html) 08:10:11 INFO - PROCESS | 30360 | __metrics Screen width/height:1600/1200 08:10:11 INFO - PROCESS | 30360 | colorDepth:24 08:10:11 INFO - PROCESS | 30360 | Browser inner width/height: 1024/697 08:10:11 INFO - PROCESS | 30360 | __metrics 08:10:11 INFO - PROCESS | 30360 | 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" 08:10:11 INFO - PROCESS | 30360 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:10:12 INFO - PROCESS | 30360 | console.error: PushService: 08:10:12 INFO - PROCESS | 30360 | stateChangeProcessEnqueue: Error transitioning state 08:10:12 INFO - PROCESS | 30360 | UnknownError 08:10:12 INFO - TEST-INFO | 30360: exit 0 08:10:12 INFO - Browser initialized. 08:10:12 INFO - Running cycle 1/1 for dromaeo_css test... 08:10:12 INFO - TEST-INFO | started process 30440 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoQQkz_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:10:25 INFO - PROCESS | 30440 | RSS: Main: 174919680 08:10:25 INFO - PROCESS | 30440 | 08:11:15 INFO - PROCESS | 30440 | 1474643475857 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] 08:13:29 INFO - PROCESS | 30440 | Cycle 1(1): loaded http://localhost:33103/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33103/tests/dromaeo/cssquery-ext.html) 08:13:30 INFO - PROCESS | 30440 | RSS: Main: 285364224 08:13:30 INFO - PROCESS | 30440 | 08:16:33 INFO - PROCESS | 30440 | Cycle 1(1): loaded http://localhost:33103/tests/dromaeo/cssquery-ext.html (next: http://localhost:33103/tests/dromaeo/cssquery-jquery.html) 08:16:34 INFO - PROCESS | 30440 | RSS: Main: 273768448 08:16:34 INFO - PROCESS | 30440 | 08:19:36 INFO - PROCESS | 30440 | Cycle 1(1): loaded http://localhost:33103/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33103/tests/dromaeo/cssquery-mootools.html) 08:19:36 INFO - PROCESS | 30440 | RSS: Main: 219660288 08:19:36 INFO - PROCESS | 30440 | 08:22:39 INFO - PROCESS | 30440 | Cycle 1(1): loaded http://localhost:33103/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33103/tests/dromaeo/cssquery-prototype.html) 08:22:39 INFO - PROCESS | 30440 | RSS: Main: 259379200 08:22:39 INFO - PROCESS | 30440 | 08:25:42 INFO - PROCESS | 30440 | Cycle 1(1): loaded http://localhost:33103/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33103/tests/dromaeo/cssquery-yui.html) 08:25:43 INFO - PROCESS | 30440 | RSS: Main: 219033600 08:25:43 INFO - PROCESS | 30440 | 08:28:46 INFO - PROCESS | 30440 | Cycle 1(1): loaded http://localhost:33103/tests/dromaeo/cssquery-yui.html (next: http://localhost:33103/tests/dromaeo/cssquery-dojo.html) 08:28:46 INFO - PROCESS | 30440 | RSS: Main: 314036224 08:28:46 INFO - PROCESS | 30440 | 08:28:46 INFO - PROCESS | 30440 | __start_tp_report 08:28:46 INFO - PROCESS | 30440 | _x_x_mozilla_page_load 08:28:46 INFO - PROCESS | 30440 | _x_x_mozilla_page_load_details 08:28:46 INFO - PROCESS | 30440 | |i|pagename|runs| 08:28:46 INFO - PROCESS | 30440 | |0;dojo.html;2628.6057091436287;2644.986775066124;2681.7452342027514;2682.396460796321;2696.892124315026;4614.700044497105;4624.514425985265;4753.976230118853;4803.831865884699;4890.535399137081;4699.365585645936;4705.647076469261;4729.054189162164;4755.120302743995;4806.855794326167;4347.760873151976;4355.956440435602;4407.691461597673;4429.889252768674;4443;4481.865544033684;4484.573965473275;4485.032576593336;4492.460904691426;4504.414426124616;4354.259775838115;4436.933445998313;4459.0413061192;4472.932906006413;4565.794539245725;4373.125374925028;4375.14684636496;4418.977905110486;4436.800343984529;4441.733495990251;4399.670024748125;4403.493598236179;4424.314231294123;4468.084042771224;4484.484284307314;4749.073930583538;4781.665283430161;4804.447488538793;4808.110499557558;4854.296127061556;4985.551300382983;5010.849674509771;5043.470435604282;5079.288899554065;5135.6148288878485;5124.02643497738;5126.128558145087;5133.512316329943;5179.559737422323;5181.715005674687;4770.61835053195;4771.308160316735;4775.21209000511;4778.952210477851;4841.225403935354;5071.492850714899;5094.312267843868;5166.767495462713;5241.371035475691;5317.7341132943975;4924.113659541245;4935.925961110586;4937.136001199776;4998.750062496861;5005.499450054966;5006.974965125151;5009;5011.323471331397;5019.14674505335;5085.542301192911;4929.408470983505;4945.134601444733;4959.90080198394;4971.925421118686;5021.422536408287;4943.209086546135;4972.776225069881;5006.6495345325475;5065.772040258197;5070.062038522885;4367.497737760198;4367.519572846984;4402.823887044547;4425.137098265872;4427.601515863524;3808.181241033136;3811.866584669523;3820.56063552695;3841.4621952926614;3862.1117143057254;4318.157959197926;4355.80398882051;4400.669949753717;4401.823927042947;4455.532169122261;5062.392512898476;5103.157978933508;5117.513836185556;5195.948040519622;5201.5838732901275;4399.054203346232;4401.537838526909;4452.933206001912;4452.9554704453185;4465.285554311295;4619.260918253063;4629.166749984967;4632.8881068543305;4635.119327327797;4695.413073365829;4705.600023997861;4752.738599376929;4795.832145874878;4829.348038014823;4844.95155048445;5150.330457040561;5195.6622819516615;5196.948030519647;5217.739113044257;5256.89486210266;4883.145449546386;4886.780094895667;4891.26631005352;4899.730514821719;4943.060818444484;4933.975330123327;4982.053409852117;5046.520580544842;5061.4179369373;5062.797488100435;5006.574441172541;5023.748812559431;5029.773660185374;5053.84838454847;5115.488451154854;4920.114379411597;4932.062908047459;4932.358793356841;4935.851924442272;4993.126202914403;4877.3903262092235;4917.606591472745;4928.482509336468;4929.580985616263;4989.201727723546;4794.832180873653;4813.542713442217;4814.8796280093275;4834.395700537433;4885.65800393969;4900.90198196027;4921.680090794087;4929.482404347492;4933.451818717368;4986.376702912136;4769;4772.331873537638;4783.617310615212;4790.969941462602;4816.434658735855 08:28:46 INFO - PROCESS | 30440 | |1;ext.html;558.6899270904648;561.0238185557131;566.1536003674507;578.6585914310556;582.664967643605;27604.585931211048;37898.62101378989;38860.222795544076;38903.61096389035;43583.564164358344;41024.38463423051;41386.793066034705;41407.378889316606;41467.58532414675;41562;7223.855522889539;7700.8459830803495;7847.764567062969;7857.607119643995;7859.842803143933;7326.157491888421;7429.368503677194;7432.739854105107;9764.804703905918;9952.701418957442;10164.64423745169;10236.795264094713;10238.283320167591;10239.385636861774;10243.23175761817;10084.798304033915;10095.798084038352;10115.848262276071;10145.797084058315;10171.898281017244;9839.262055345878;9902.603895844157;9902.702918912444;9913.75215619608;9950.751231219205;38508.229835403414;38564.80717596422;38747.41878871819;38781.61218387808;38872.222555549015;2983.92617131094;3132.530120481923;3232.191952011997;3245.318483118548;3319.6348401675796;28646.283842904093;28783.56824647611;29134.70865291341;29501.409971800444;30605.38789224203;3304.3556506481245;3374.578177727784;3380.7802492837886;3415.4706020566605;3417.8120203388803;256921;257225;257983;258488.7075564629;258702.70648646823;30451.670957582333;31523;50472.242916356285;50719.492805072216;50732.926707328974;32878.506822397685;33088;33191.66808331886;33208.1697957553;33327.83336083352;13312.334383280991;13427.664308392368;13463.865361346458;13466.259355735529;13472.461101555828;10826.783464330827;10885.23803333759;10954.39750813697;11022.118230541537;11038.061764749926;7108.573485590778;7315.63421828917;7497.62511874415;7770.41721870862;7794.10367807698;3068.70847269509;3116.8909088181804;3134.357456721367;3166.0501849445072;3173.8730450782173;794.8767940969159;878.4026861733954;882.223643193998;962.0523784072683;971.5530855806409;26364.60453093205;27864;28247.138860314797;28546.714532854407;28650.856745716137;950.8621249918862;993.7366597851575;1006.4665727164614;1037.1547189040907;1045.5660900726114;14443.133411995314;14953.40186392532;15074.698506030038;15364.846351536566;15414.768778468331;119315;120440;120638;120817.39591302162;121180.39409802895;48997.51002490001;49355.50644493509;49419.50580494221;49420;49467.50532494629;1066.7919755647574;1093.8577984861918;1140.5893878203674;1158.5250047480492;1175.0305997552055;25310.367240819127;29062.27344316409;29763.55354669725;29870.980319624436;30004.554996633124;41462.1707565853;41951.37072943847;41990.79004604957;42009.57990420057;42059.7897010513;303295;303979;304079;305390;306388;24061.879690601436;24545.386365341008;24698.50602987966;25289.873550632867;25751;42328.1534369317;42604.36093458663;42649;42813;43020.35469467898;34990.47514287237;35055.47416788699;35593.288134237686;35639.64360356363;35661.28677426489;35799.82100089483;35813.28373432464;36063;36319;36341.45487817632;34804.82597586996;35158.12104697301;35456.82271588626;35465.64534354623;36076.45885311775;30984.53523197199;32940.1764955878;33173.50239746358;33180.83409583033;33394.666053339155;21495;21699.783002170407;21835.67246491272;21874;22194.66707999349 08:28:46 INFO - PROCESS | 30440 | |2;jquery.html;356.4724208171907;368.29839156407036;377.49604278288484;379.37024539264826;393.81490699371284;12297.631071067872;12434;13251.469941202364;16127.677446451064;16974.236159372827;16301.429449969253;16723.916380418083;17143.914280428613;17222.483325500223;17330.220140093694;4761.333413322138;5063.645544811865;5078.796848126089;5080.339555857752;5092.465291144432;3704.3887758519813;3897.824597893102;5038.748062596856;5117.667351622133;5123.5388815006645;5684.2326285951285;5900.940990590082;5941.584089113764;6057.454829065383;6065.575409721321;5698.458646428583;5874.6181498202905;5905.084711869667;6030.608010479326;6036.607620504675;5210.270562121306;5212.192110222922;5214.687118772886;5214.791408343662;5215.687058776485;19604.901975490033;19773.307934222375;20376.184952601878;20460.79539204604;20704.58590828175;1596.5529651697543;1914.0716752375088;1950.882947023169;1958.079702539804;1994.6110508450859;9025.368224224307;9224.446533207962;9623;11468.942655286754;13629.659258518517;1743.1458585293242;1788.3561917709615;1792.3010026089705;1813.9841688654396;1820.8452281556083;63427.682861585396;65427.99999999953;66397.66801166012;68115;70045.29954700438;9668.903310966942;9832.557534910804;9853.704388868346;9961.402315860927;10143.18854491639;13394.531191408254;13396.93301533486;13402.463901444027;13404.128731632607;13428.395722192525;6897.310268973062;7030.683619237147;7089.539179953286;7275.345218930322;7283.2716728327805;6685.431738302202;6703.497237707192;6718.462522998148;6911.861762764716;6913.654317284116;4151.398047283187;4221.514525829569;4296.4414626098405;4306.9663280813;4319.6889664029595;1690.6027083635336;1751.1856986501339;1760.0935518208132;1796.2365994452305;1802.6665066962653;814.608987685914;836.1680128272408;883.8995450663964;885.2784980241083;942.7690215897012;15854.44509442187;16525.25636346367;16739.66520669604;16790.16049197535;17394.565135871704;793.2900054451234;822.3380178955879;824.1799409587499;834.61190546395;863.9265662418765;9100.772480687903;9626.422414655142;9654.613815447303;9655.22758179344;9712.805743885225;267948;351950;354173.45826541405;354417;355966;83889.58055209684;83975;84713.15286847176;84778;87264.1273587256;927.684587240328;952.3286083311249;953.0755167487526;954.3939598354956;956.8182045411489;15174.31715572824;15363.846361536689;15467.613309667347;15845.841541584437;16211.189440528162;30634.84682576573;34102.317953641286;37323.81338093292;38170.61829381782;38987.6101238984;51521;51754.48245517497;51936.74031629818;52012.47987520076;54270.005498075356;7429.8142546436775;7507.361874240751;7671.53970761756;7879.645415956181;7986.321162701235;11473.311601303949;11565.132615053737;11575.826362604736;11643.59247426336;11745.941270293593;10087.478130467383;10241.23190760681;10408.750949886062;10494.265401421828;10919.454027298445;10224.59101635956;10278.434686092336;10430.68707938763;10507.47462626881;10573.4713264338;10200;10293.897061029294;10461.9476902615;10513.737156571147;10859.457027148768;7381.630918453949;7462.253774622712;7490.775276741707;7517.962410187914;7537.54774713519;10155.898441015495;10166.339187952759;10458.790824183321;10624.096951758878;11096.889031109586 08:28:46 INFO - PROCESS | 30440 | |3;mootools.html;1229.772492088963;1351.1892864281429;1377.3113443278362;1427.8786303164231;1702.812690604034;6981.6509174541325;7545.358644515216;7680.078390593137;7941.841163176748;7943.404244681643;8003.239692229244;8097.797555061126;8099.838003239932;8101.878471822927;8106.797330066736;2196.1435040334322;2209.3371988403496;2215.9113635454564;2217.800397964183;2228.3649159989404;2157.7087093242367;2168.035224325176;2188.1794327127327;2198.1756841184556;2200.526886719355;2151.3868547463976;2157.9892100539473;2176.542925985537;2180.9127634894667;2199.483121466454;2129.169623846701;2129.872207667537;2134.2103421733905;2151.0320355839935;2154.1598776477185;2055.7738648748627;2101.894905254731;2102.57948410317;2103.8001389867936;2108.968365474519;7934.880976785353;7951;8025.3178479829285;8028.397870159762;8041.758747237593;4673.649476289258;4831.830885918976;4831.975840120812;4891.608671306287;4904.362432883738;2826.590144429046;3001.309698769295;3013.367192889496;3027.16752892954;3056.9541456878164;923.9168474837297;928.9442633441947;938.5823308627663;955.1451450951429;955.6034245787989;10942.671719848417;11029;11060.115190784718;11060.115190784798;11068.114550835913;4099.323611604112;4103.958960410358;4188.602082802129;4240.957590424118;4300.290452075373;8192.221738934792;8308.5430301334;8312.792180195544;8315.00219973607;8315.04376996641;4681.016986432819;4681.297805329228;4686.835960741358;4688.156131896223;4688.718676879398;3676.17286110623;3874.1864208516527;4001.7198796084576;4322.956770432318;4348.717333373384;3191.29265842773;3547.5565554305713;3548.2371290172737;3549.048023587017;3552.573691157026;1037.9377237365782;1041.3023274406166;1058.1534772182224;1058.9894101059044;1063.4310643805527;708.6492186367781;818.6766227340167;819.3445243804932;840.1766269056359;841.5035129273758;5047.217681259411;5166.560842328444;5208.192730126761;5213.635045546851;5404.675719456766;398.62330098057635;400.5933977013334;405.17546792277574;412.82867609941536;426.08179373450264;3505.4391297392294;3595;3831.7700937943814;3879.4374815652136;3928.941065884014;9674.467904265333;10058.59765609382;10194.337368071052;10216.948915255376;10221.540030698636;10125.848112278174;10194.082532571956;10199.847002294971;10202.132818710492;10210.744731381626;7437.1447283562;7497.587632680146;7539.585322807188;7591.962040189764;7650.081990161105;5315.441878602691;5321.255024296524;5336.439673834191;5410.101252171873;5510.586705997146;8969.641214351353;9105.863412048957;9176.95411522938;9204.447733136034;9215.44707317563;8249.092599814136;9053.77365565866;9240;9263.490508022123;9305.488198149167;6336.239651241881;6677.399034086956;6865.176178858569;6899.75850845218;7033.050538177281;7608.923910760822;7643.503172293783;7671.578063206354;7679.539227646359;7727.768166955;6753.831154221184;6806.251312355538;6806.387425131762;6806.76176333826;6816.829579260559;6727.562708423937;6785.6946437411425;6810.9318906810295;6987.336203060701;7030.894536581853;6435.710393032231;6441.3880681335195;6471.644059576768;6487.124238227779;6487.513436492376;4344.782760861881;4442.178197033559;4506.729596224237;4537.773111344353;4562.65780066503;4488;4551.340055691972;4567.931481027721;4569.497355290849;4748.596369308648 08:28:46 INFO - PROCESS | 30440 | |4;prototype.html;278.6878695860636;282.60858710685704;284.88177406376343;286.9913902582922;300.4951681175627;4843.80624775009;4871.902561948759;4881.341018962444;4893.192623217169;4896.975515122419;4588.54114588541;4687.414073240845;4756.262779269219;4797.424309082906;4867.342908707324;3755.380362240227;3759.718021148411;3771.4531392948006;3773.52830896138;3774.8109345556063;3752.287065457568;3760.1539653578;3777.527809023872;3778.9433158502643;3784.829682664287;3523.330567192238;3542.3977923752896;3697.611750766171;3707.388280933643;3768.2651882882847;3752.8123593820337;3758.8120593970466;3768.8680896168776;3771.15149091455;3773.905652358699;3302.9009129725905;3311.0563489405404;3312.420326442863;3314.2211580278617;3315.419801534746;4609.312549960018;4693.6479764017495;4714.481407045222;4726.243800991825;4736.384270044872;4165.83336666533;4223.260929337384;4228.873133805991;4240.151969606091;4245.915081698379;4943.752812359367;4965.354503914468;4975.825846095406;4988.625853060998;4998.600111991068;3581.4627805829073;3584.444411116281;3591.5510561179854;3593.2813437312643;3594.7663401878795;5100.591952643779;5161.251618515332;5216.895662086775;5235.869103272448;5236.7119808410525;3644.890653280406;3649.9270014600093;3653.4337177737493;3659.341318562684;3660.3411385950253;3711.9072023199637;3713.424419215026;3724.795136267477;3725.403935370328;3730.850765969385;4223.21870453967;4228.667969589569;4248.596383343577;4249.128928569636;4249.490061192615;4810.39870016248;5066.645334826527;5080;5080.74596270185;5087.516685914832;1240.1938739819009;1244.966677657542;1248.806435002576;1252.5803855708439;1252.6367353467392;784.7724159993538;795.323974621567;798.504926945286;810.9959450202829;830.9086000539936;4417.602415782595;4420.624246938982;4424.247877860771;4425.3140763181755;4431.158079964796;5104.897902041938;5125;5130.923036154386;5140.742962851842;5147.716875571805;4330.895621616468;4393.264660459165;4395.626371758436;4415.337699345124;4443.400140980991;2722.2105589379253;2748.2548581650394;2755.9862200689267;2756.379814541712;2762.4392218396542;4878.829240976549;4890.364252647133;4890.975545122323;4894.877628059327;4919.310517112166;5078;5193.740312984336;5245.134552798745;5259.289995850511;5260.133227391005;4866;4869.586085182728;4889.462159162489;4892.217245240816;4897.167481528078;5105.744712764273;5124.666896651705;5127.4872512748425;5129.384473863161;5133.794648214179;4853;5033.345665063518;5034.521720436553;5149.150390185578;5156.303898973741;5019.974900125476;5026.52248036436;5030.748462576783;5034.622403319839;5048.848534543969;3651.7626354286886;3668.734286671094;3672.1554042570892;3673.9448908265863;3675.7243206760136;5123.410807757155;5202.0116177926075;5217.2434996925995;5288.206768984683;5301.125314323093;5096.006278775603;5115.386153661584;5116.465060481766;5119.539241468136;5120.48795120485;5106.004329155779;5110.71891045996;5121.334226550524;5124.487551244845;5129.948700512947;4784.952150478451;5016.322796422436;5040.243963405518;5047.596192304681;5048.242763585492;4879.219324907997;4982.950170498394;5008.549230569266;5140.665856719302;5145.176771716508;4973.751312434291;4990.976849745721;4994.850154495371;5009.373828271466;5016.799328026838 08:28:46 INFO - PROCESS | 30440 | |5;yui.html;644.8387903024244;646.1115965547373;673.8113328268083;710.0414440505318;742.5841528743904;12675.112742108056;13820.792688109686;13847.376868040938;13847.584572462816;13877.16736995781;12303;12330.383480825967;12483.063770217248;12506.062045346589;12620.432080556375;625.4058644287921;643.8068579426177;736.2269616902258;741.5550669598252;770.9961450192741;764.4534158076974;776.1191048160322;776.8407476467339;776.8756998880181;777.059757693192;824.11819353292;825.781167990483;825.9876101858476;825.9876101858476;826.1985873702499;654.2868273581819;675.3179288918179;799.5562462833125;821.7863355527576;823.1850468036661;597.3459062326746;601.21541388488;601.2184160591214;601.3565484931125;601.8555546668767;12598.622041338775;12600.68498287541;12604.369781510888;12604.432800523999;12616.810747838697;12516.81224781629;12723.491060357575;13132.803007954888;13305.467781288833;13522.93238533801;11694;11751.882481175164;11923.344216068113;12093.45579448927;12520.81218781719;4148.124681341879;4195;4209.515905670826;4246.171996460692;4346.043870348518;66497.99999999952;67443;68026.65986670085;68226.65886670584;68284;10088.344257623232;10104.69685909424;10126.341787783771;10140.239482038876;10295.485225738683;17231.310747569958;17897.284108635507;17909.373171938918;19454.8054519453;19528.121234544196;6833.453323734089;6909.378155965987;7046.541974771623;7114.21743608213;7129.89305160423;3538.8230588470988;3782.0922978484964;3806.8477260909253;3820.84716611338;3875.5736868944396;2929.5605659151297;3065.4635438798123;3072.293372524332;3076.6923307669504;3087.6449208340878;513.8047541934042;518.9948100519022;524.6432425950314;531.7926008856549;533.9813106541252;560.6019725994508;614.1708693264147;617.3147805935408;622.5704264057877;625.4402309932585;8465.534395608302;8499.138063798291;8579.957100214584;8797.868031979526;8956.328275379372;560.6916196092133;572.7794799002331;575.4044563876367;581.5260562641433;595.7378753348513;3914.980425097913;4229.302165142779;4240.872773816729;4254.7659878706345;4444.644428445717;57951;86124;98845.50577247211;103905.48047259715;106018.46990764997;85805.57097214473;87606;87949.56025219832;88695;90067;76252;77475;77496;79193;79684.20315796883;7963.203679632222;8035.397345199017;8042.718504852302;8057;8165.274952628588;45860.770696146305;47407.76296118497;47928;48083.27875081806;48424.757876210395;62573.06140407988;63049;68717;69015.65492172507;69834.65082674554;9725.270604704534;9844.852327215242;9898.059684329977;10225.181985441295;10537.315074520131;11103.5558577656;11205.383703896365;11452.14108941816;11614.419279035845;11712.590059347882;10165.695029149138;10454.947725261325;10619.575216991234;10778.784424311627;11197.944010279896;10689;10734.463276835972;11137.164712646421;11252.493637786156;11509.827352589551;10501.737456563342;10673.519691613741;10689.839652405375;11236.381998990135;11260.38067906273;8634.78413039654;8867.68963086289;9210.263178945803;9295.024022477543;9423.151916327564;9279.814403711753;9610.471424071464;9728.854067189139;9734.269929755439;9789.951050244988 08:28:46 INFO - PROCESS | 30440 | __end_tp_report 08:28:46 INFO - PROCESS | 30440 | __start_cc_report 08:28:46 INFO - PROCESS | 30440 | _x_x_mozilla_cycle_collect,960 08:28:46 INFO - PROCESS | 30440 | __end_cc_report 08:28:46 INFO - PROCESS | 30440 | __startTimestamp1474644526745__endTimestamp 08:28:46 INFO - PROCESS | 30440 | 08:28:46 INFO - PROCESS | 30440 | ------- Summary: start ------- 08:28:46 INFO - PROCESS | 30440 | Number of tests: 6 08:28:46 INFO - PROCESS | 30440 | 08:28:46 INFO - PROCESS | 30440 | [#0] dojo.html Cycles:165 Average:4710.98 Median:4816.43 stddev:474.33 (9.8%) stddev-sans-first:446.77 08:28:46 INFO - PROCESS | 30440 | Values: 2628.6 2645.0 2681.7 2682.4 2696.9 4614.7 4624.5 4754.0 4803.8 4890.5 4699.4 4705.6 4729.1 4755.1 4806.9 4347.8 4356.0 4407.7 4429.9 4443.0 4481.9 4484.6 4485.0 4492.5 4504.4 4354.3 4436.9 4459.0 4472.9 4565.8 4373.1 4375.1 4419.0 4436.8 4441.7 4399.7 4403.5 4424.3 4468.1 4484.5 4749.1 4781.7 4804.4 4808.1 4854.3 4985.6 5010.8 5043.5 5079.3 5135.6 5124.0 5126.1 5133.5 5179.6 5181.7 4770.6 4771.3 4775.2 4779.0 4841.2 5071.5 5094.3 5166.8 5241.4 5317.7 4924.1 4935.9 4937.1 4998.8 5005.5 5007.0 5009.0 5011.3 5019.1 5085.5 4929.4 4945.1 4959.9 4971.9 5021.4 4943.2 4972.8 5006.6 5065.8 5070.1 4367.5 4367.5 4402.8 4425.1 4427.6 3808.2 3811.9 3820.6 3841.5 3862.1 4318.2 4355.8 4400.7 4401.8 4455.5 5062.4 5103.2 5117.5 5195.9 5201.6 4399.1 4401.5 4452.9 4453.0 4465.3 4619.3 4629.2 4632.9 4635.1 4695.4 4705.6 4752.7 4795.8 4829.3 4845.0 5150.3 5195.7 5196.9 5217.7 5256.9 4883.1 4886.8 4891.3 4899.7 4943.1 4934.0 4982.1 5046.5 5061.4 5062.8 5006.6 5023.7 5029.8 5053.8 5115.5 4920.1 4932.1 4932.4 4935.9 4993.1 4877.4 4917.6 4928.5 4929.6 4989.2 4794.8 4813.5 4814.9 4834.4 4885.7 4900.9 4921.7 4929.5 4933.5 4986.4 4769.0 4772.3 4783.6 4791.0 4816.4 08:28:46 INFO - PROCESS | 30440 | 08:28:46 INFO - PROCESS | 30440 | [#1] ext.html Cycles:180 Average:38586.62 Median:33177.17 stddev:63283.94 (190.7%) stddev-sans-first:63397.05 08:28:46 INFO - PROCESS | 30440 | Values: 558.7 561.0 566.2 578.7 582.7 27604.6 37898.6 38860.2 38903.6 43583.6 41024.4 41386.8 41407.4 41467.6 41562.0 7223.9 7700.8 7847.8 7857.6 7859.8 7326.2 7429.4 7432.7 9764.8 9952.7 10164.6 10236.8 10238.3 10239.4 10243.2 10084.8 10095.8 10115.8 10145.8 10171.9 9839.3 9902.6 9902.7 9913.8 9950.8 38508.2 38564.8 38747.4 38781.6 38872.2 2983.9 3132.5 3232.2 3245.3 3319.6 28646.3 28783.6 29134.7 29501.4 30605.4 3304.4 3374.6 3380.8 3415.5 3417.8 256921.0 257225.0 257983.0 258488.7 258702.7 30451.7 31523.0 50472.2 50719.5 50732.9 32878.5 33088.0 33191.7 33208.2 33327.8 13312.3 13427.7 13463.9 13466.3 13472.5 10826.8 10885.2 10954.4 11022.1 11038.1 7108.6 7315.6 7497.6 7770.4 7794.1 3068.7 3116.9 3134.4 3166.1 3173.9 794.9 878.4 882.2 962.1 971.6 26364.6 27864.0 28247.1 28546.7 28650.9 950.9 993.7 1006.5 1037.2 1045.6 14443.1 14953.4 15074.7 15364.8 15414.8 119315.0 120440.0 120638.0 120817.4 121180.4 48997.5 49355.5 49419.5 49420.0 49467.5 1066.8 1093.9 1140.6 1158.5 1175.0 25310.4 29062.3 29763.6 29871.0 30004.6 41462.2 41951.4 41990.8 42009.6 42059.8 303295.0 303979.0 304079.0 305390.0 306388.0 24061.9 24545.4 24698.5 25289.9 25751.0 42328.2 42604.4 42649.0 42813.0 43020.4 34990.5 35055.5 35593.3 35639.6 35661.3 35799.8 35813.3 36063.0 36319.0 36341.5 34804.8 35158.1 35456.8 35465.6 36076.5 30984.5 32940.2 33173.5 33180.8 33394.7 21495.0 21699.8 21835.7 21874.0 22194.7 08:28:46 INFO - PROCESS | 30440 | 08:28:46 INFO - PROCESS | 30440 | [#2] jquery.html Cycles:180 Average:22931.61 Median:4186.46 stddev:56507.96 (1349.8%) stddev-sans-first:56641.06 08:28:46 INFO - PROCESS | 30440 | Values: 356.5 368.3 377.5 379.4 393.8 12297.6 12434.0 13251.5 16127.7 16974.2 16301.4 16723.9 17143.9 17222.5 17330.2 4761.3 5063.6 5078.8 5080.3 5092.5 3704.4 3897.8 5038.7 5117.7 5123.5 5684.2 5900.9 5941.6 6057.5 6065.6 5698.5 5874.6 5905.1 6030.6 6036.6 5210.3 5212.2 5214.7 5214.8 5215.7 19604.9 19773.3 20376.2 20460.8 20704.6 1596.6 1914.1 1950.9 1958.1 1994.6 9025.4 9224.4 9623.0 11468.9 13629.7 1743.1 1788.4 1792.3 1814.0 1820.8 63427.7 65428.0 66397.7 68115.0 70045.3 9668.9 9832.6 9853.7 9961.4 10143.2 13394.5 13396.9 13402.5 13404.1 13428.4 6897.3 7030.7 7089.5 7275.3 7283.3 6685.4 6703.5 6718.5 6911.9 6913.7 4151.4 4221.5 4296.4 4307.0 4319.7 1690.6 1751.2 1760.1 1796.2 1802.7 814.6 836.2 883.9 885.3 942.8 15854.4 16525.3 16739.7 16790.2 17394.6 793.3 822.3 824.2 834.6 863.9 9100.8 9626.4 9654.6 9655.2 9712.8 267948.0 351950.0 354173.5 354417.0 355966.0 83889.6 83975.0 84713.2 84778.0 87264.1 927.7 952.3 953.1 954.4 956.8 15174.3 15363.8 15467.6 15845.8 16211.2 30634.8 34102.3 37323.8 38170.6 38987.6 51521.0 51754.5 51936.7 52012.5 54270.0 7429.8 7507.4 7671.5 7879.6 7986.3 11473.3 11565.1 11575.8 11643.6 11745.9 10087.5 10241.2 10408.8 10494.3 10919.5 10224.6 10278.4 10430.7 10507.5 10573.5 10200.0 10293.9 10461.9 10513.7 10859.5 7381.6 7462.3 7490.8 7518.0 7537.5 10155.9 10166.3 10458.8 10624.1 11096.9 08:28:46 INFO - PROCESS | 30440 | 08:28:46 INFO - PROCESS | 30440 | [#3] mootools.html Cycles:180 Average:5182.50 Median:4684.07 stddev:2978.42 (63.6%) stddev-sans-first:2971.96 08:28:46 INFO - PROCESS | 30440 | Values: 1229.8 1351.2 1377.3 1427.9 1702.8 6981.7 7545.4 7680.1 7941.8 7943.4 8003.2 8097.8 8099.8 8101.9 8106.8 2196.1 2209.3 2215.9 2217.8 2228.4 2157.7 2168.0 2188.2 2198.2 2200.5 2151.4 2158.0 2176.5 2180.9 2199.5 2129.2 2129.9 2134.2 2151.0 2154.2 2055.8 2101.9 2102.6 2103.8 2109.0 7934.9 7951.0 8025.3 8028.4 8041.8 4673.6 4831.8 4832.0 4891.6 4904.4 2826.6 3001.3 3013.4 3027.2 3057.0 923.9 928.9 938.6 955.1 955.6 10942.7 11029.0 11060.1 11060.1 11068.1 4099.3 4104.0 4188.6 4241.0 4300.3 8192.2 8308.5 8312.8 8315.0 8315.0 4681.0 4681.3 4686.8 4688.2 4688.7 3676.2 3874.2 4001.7 4323.0 4348.7 3191.3 3547.6 3548.2 3549.0 3552.6 1037.9 1041.3 1058.2 1059.0 1063.4 708.6 818.7 819.3 840.2 841.5 5047.2 5166.6 5208.2 5213.6 5404.7 398.6 400.6 405.2 412.8 426.1 3505.4 3595.0 3831.8 3879.4 3928.9 9674.5 10058.6 10194.3 10216.9 10221.5 10125.8 10194.1 10199.8 10202.1 10210.7 7437.1 7497.6 7539.6 7592.0 7650.1 5315.4 5321.3 5336.4 5410.1 5510.6 8969.6 9105.9 9177.0 9204.4 9215.4 8249.1 9053.8 9240.0 9263.5 9305.5 6336.2 6677.4 6865.2 6899.8 7033.1 7608.9 7643.5 7671.6 7679.5 7727.8 6753.8 6806.3 6806.4 6806.8 6816.8 6727.6 6785.7 6810.9 6987.3 7030.9 6435.7 6441.4 6471.6 6487.1 6487.5 4344.8 4442.2 4506.7 4537.8 4562.7 4488.0 4551.3 4567.9 4569.5 4748.6 08:28:46 INFO - PROCESS | 30440 | 08:28:46 INFO - PROCESS | 30440 | [#4] prototype.html Cycles:180 Average:4182.10 Median:4827.10 stddev:1224.64 (25.4%) stddev-sans-first:1192.52 08:28:46 INFO - PROCESS | 30440 | Values: 278.7 282.6 284.9 287.0 300.5 4843.8 4871.9 4881.3 4893.2 4897.0 4588.5 4687.4 4756.3 4797.4 4867.3 3755.4 3759.7 3771.5 3773.5 3774.8 3752.3 3760.2 3777.5 3778.9 3784.8 3523.3 3542.4 3697.6 3707.4 3768.3 3752.8 3758.8 3768.9 3771.2 3773.9 3302.9 3311.1 3312.4 3314.2 3315.4 4609.3 4693.6 4714.5 4726.2 4736.4 4165.8 4223.3 4228.9 4240.2 4245.9 4943.8 4965.4 4975.8 4988.6 4998.6 3581.5 3584.4 3591.6 3593.3 3594.8 5100.6 5161.3 5216.9 5235.9 5236.7 3644.9 3649.9 3653.4 3659.3 3660.3 3711.9 3713.4 3724.8 3725.4 3730.9 4223.2 4228.7 4248.6 4249.1 4249.5 4810.4 5066.6 5080.0 5080.7 5087.5 1240.2 1245.0 1248.8 1252.6 1252.6 784.8 795.3 798.5 811.0 830.9 4417.6 4420.6 4424.2 4425.3 4431.2 5104.9 5125.0 5130.9 5140.7 5147.7 4330.9 4393.3 4395.6 4415.3 4443.4 2722.2 2748.3 2756.0 2756.4 2762.4 4878.8 4890.4 4891.0 4894.9 4919.3 5078.0 5193.7 5245.1 5259.3 5260.1 4866.0 4869.6 4889.5 4892.2 4897.2 5105.7 5124.7 5127.5 5129.4 5133.8 4853.0 5033.3 5034.5 5149.2 5156.3 5020.0 5026.5 5030.7 5034.6 5048.8 3651.8 3668.7 3672.2 3673.9 3675.7 5123.4 5202.0 5217.2 5288.2 5301.1 5096.0 5115.4 5116.5 5119.5 5120.5 5106.0 5110.7 5121.3 5124.5 5129.9 4785.0 5016.3 5040.2 5047.6 5048.2 4879.2 4983.0 5008.5 5140.7 5145.2 4973.8 4991.0 4994.9 5009.4 5016.8 08:28:46 INFO - PROCESS | 30440 | 08:28:46 INFO - PROCESS | 30440 | [#5] yui.html Cycles:180 Average:18014.86 Median:566.74 stddev:26019.12 (4591.1%) stddev-sans-first:26059.42 08:28:46 INFO - PROCESS | 30440 | Values: 644.8 646.1 673.8 710.0 742.6 12675.1 13820.8 13847.4 13847.6 13877.2 12303.0 12330.4 12483.1 12506.1 12620.4 625.4 643.8 736.2 741.6 771.0 764.5 776.1 776.8 776.9 777.1 824.1 825.8 826.0 826.0 826.2 654.3 675.3 799.6 821.8 823.2 597.3 601.2 601.2 601.4 601.9 12598.6 12600.7 12604.4 12604.4 12616.8 12516.8 12723.5 13132.8 13305.5 13522.9 11694.0 11751.9 11923.3 12093.5 12520.8 4148.1 4195.0 4209.5 4246.2 4346.0 66498.0 67443.0 68026.7 68226.7 68284.0 10088.3 10104.7 10126.3 10140.2 10295.5 17231.3 17897.3 17909.4 19454.8 19528.1 6833.5 6909.4 7046.5 7114.2 7129.9 3538.8 3782.1 3806.8 3820.8 3875.6 2929.6 3065.5 3072.3 3076.7 3087.6 513.8 519.0 524.6 531.8 534.0 560.6 614.2 617.3 622.6 625.4 8465.5 8499.1 8580.0 8797.9 8956.3 560.7 572.8 575.4 581.5 595.7 3915.0 4229.3 4240.9 4254.8 4444.6 57951.0 86124.0 98845.5 103905.5 106018.5 85805.6 87606.0 87949.6 88695.0 90067.0 76252.0 77475.0 77496.0 79193.0 79684.2 7963.2 8035.4 8042.7 8057.0 8165.3 45860.8 47407.8 47928.0 48083.3 48424.8 62573.1 63049.0 68717.0 69015.7 69834.7 9725.3 9844.9 9898.1 10225.2 10537.3 11103.6 11205.4 11452.1 11614.4 11712.6 10165.7 10454.9 10619.6 10778.8 11197.9 10689.0 10734.5 11137.2 11252.5 11509.8 10501.7 10673.5 10689.8 11236.4 11260.4 8634.8 8867.7 9210.3 9295.0 9423.2 9279.8 9610.5 9728.9 9734.3 9790.0 08:28:46 INFO - PROCESS | 30440 | -------- Summary: end -------- 08:28:46 INFO - PROCESS | 30440 | 08:28:47 INFO - TEST-INFO | 30440: exit 0 08:28:47 INFO - TEST-OK | dromaeo_css | took 1121166ms 08:28:47 INFO - TEST-START | kraken 08:28:47 INFO - operating with platform_type : linux_ 08:28:47 INFO - Initialising browser for kraken test... 08:28:47 INFO - TEST-INFO | started process 30750 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCnpKwB/profile http://localhost:33103/getInfo.html) 08:28:52 INFO - PROCESS | 30750 | __metrics Screen width/height:1600/1200 08:28:52 INFO - PROCESS | 30750 | colorDepth:24 08:28:52 INFO - PROCESS | 30750 | Browser inner width/height: 1024/697 08:28:52 INFO - PROCESS | 30750 | __metrics 08:28:52 INFO - PROCESS | 30750 | 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" 08:28:52 INFO - PROCESS | 30750 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:28:53 INFO - PROCESS | 30750 | console.error: PushService: 08:28:53 INFO - PROCESS | 30750 | stateChangeProcessEnqueue: Error transitioning state 08:28:53 INFO - PROCESS | 30750 | UnknownError 08:28:53 INFO - TEST-INFO | 30750: exit 0 08:28:53 INFO - Browser initialized. 08:28:53 INFO - Running cycle 1/1 for kraken test... 08:28:53 INFO - TEST-INFO | started process 30830 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCnpKwB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:29:06 INFO - PROCESS | 30830 | RSS: Main: 175230976 08:29:06 INFO - PROCESS | 30830 | 08:29:09 INFO - PROCESS | 30830 | Cycle 1(1): loaded http://localhost:33103/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33103/tests/kraken/driver.html?testName=audio-beat-detection) 08:29:10 INFO - PROCESS | 30830 | RSS: Main: 234274816 08:29:10 INFO - PROCESS | 30830 | 08:29:12 INFO - PROCESS | 30830 | Cycle 1(1): loaded http://localhost:33103/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33103/tests/kraken/driver.html?testName=audio-dft) 08:29:13 INFO - PROCESS | 30830 | RSS: Main: 218660864 08:29:13 INFO - PROCESS | 30830 | 08:29:16 INFO - PROCESS | 30830 | Cycle 1(1): loaded http://localhost:33103/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33103/tests/kraken/driver.html?testName=audio-fft) 08:29:17 INFO - PROCESS | 30830 | RSS: Main: 300695552 08:29:17 INFO - PROCESS | 30830 | 08:29:19 INFO - PROCESS | 30830 | Cycle 1(1): loaded http://localhost:33103/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33103/tests/kraken/driver.html?testName=audio-oscillator) 08:29:20 INFO - PROCESS | 30830 | RSS: Main: 210345984 08:29:20 INFO - PROCESS | 30830 | 08:29:22 INFO - PROCESS | 30830 | Cycle 1(1): loaded http://localhost:33103/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33103/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:29:22 INFO - PROCESS | 30830 | RSS: Main: 214138880 08:29:22 INFO - PROCESS | 30830 | 08:29:26 INFO - PROCESS | 30830 | Cycle 1(1): loaded http://localhost:33103/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33103/tests/kraken/driver.html?testName=imaging-darkroom) 08:29:26 INFO - PROCESS | 30830 | RSS: Main: 250564608 08:29:26 INFO - PROCESS | 30830 | 08:29:30 INFO - PROCESS | 30830 | Cycle 1(1): loaded http://localhost:33103/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33103/tests/kraken/driver.html?testName=imaging-desaturate) 08:29:30 INFO - PROCESS | 30830 | RSS: Main: 245006336 08:29:30 INFO - PROCESS | 30830 | 08:29:33 INFO - PROCESS | 30830 | Cycle 1(1): loaded http://localhost:33103/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33103/tests/kraken/driver.html?testName=json-parse-financial) 08:29:34 INFO - PROCESS | 30830 | RSS: Main: 248000512 08:29:34 INFO - PROCESS | 30830 | 08:29:36 INFO - PROCESS | 30830 | Cycle 1(1): loaded http://localhost:33103/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33103/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:29:36 INFO - PROCESS | 30830 | RSS: Main: 211185664 08:29:36 INFO - PROCESS | 30830 | 08:29:38 INFO - PROCESS | 30830 | Cycle 1(1): loaded http://localhost:33103/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33103/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:29:39 INFO - PROCESS | 30830 | RSS: Main: 219029504 08:29:39 INFO - PROCESS | 30830 | 08:29:41 INFO - PROCESS | 30830 | Cycle 1(1): loaded http://localhost:33103/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33103/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:29:42 INFO - PROCESS | 30830 | RSS: Main: 222863360 08:29:42 INFO - PROCESS | 30830 | 08:29:44 INFO - PROCESS | 30830 | Cycle 1(1): loaded http://localhost:33103/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33103/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:29:45 INFO - PROCESS | 30830 | RSS: Main: 224206848 08:29:45 INFO - PROCESS | 30830 | 08:29:48 INFO - PROCESS | 30830 | Cycle 1(1): loaded http://localhost:33103/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33103/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:29:49 INFO - PROCESS | 30830 | RSS: Main: 221642752 08:29:49 INFO - PROCESS | 30830 | 08:29:50 INFO - PROCESS | 30830 | Cycle 1(1): loaded http://localhost:33103/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33103/tests/kraken/driver.html?testName=ai-astar) 08:29:51 INFO - PROCESS | 30830 | RSS: Main: 272986112 08:29:51 INFO - PROCESS | 30830 | 08:29:51 INFO - PROCESS | 30830 | __start_tp_report 08:29:51 INFO - PROCESS | 30830 | _x_x_mozilla_page_load 08:29:51 INFO - PROCESS | 30830 | _x_x_mozilla_page_load_details 08:29:51 INFO - PROCESS | 30830 | |i|pagename|runs| 08:29:51 INFO - PROCESS | 30830 | |0;ai-astar;112;114;115;115;113;114;113;115;114;112 08:29:51 INFO - PROCESS | 30830 | |1;audio-beat-detection;156;130;122;169;126;124;127;126;160;127 08:29:51 INFO - PROCESS | 30830 | |2;audio-dft;161;161;162;161;161;160;161;161;161;161 08:29:51 INFO - PROCESS | 30830 | |3;audio-fft;76;77;76;114;79;79;77;76;95;77 08:29:51 INFO - PROCESS | 30830 | |4;audio-oscillator;84;82;112;84;84;84;114;83;82;123 08:29:51 INFO - PROCESS | 30830 | |5;imaging-gaussian-blur;116;116;117;116;124;116;117;117;118;118 08:29:51 INFO - PROCESS | 30830 | |6;imaging-darkroom;147;147;147;146;147;146;147;146;146;146 08:29:51 INFO - PROCESS | 30830 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 08:29:51 INFO - PROCESS | 30830 | |8;json-parse-financial;65;62;62;63;63;64;65;63;64;64 08:29:51 INFO - PROCESS | 30830 | |9;json-stringify-tinderbox;66;66;65;66;66;66;66;66;65;66 08:29:51 INFO - PROCESS | 30830 | |10;stanford-crypto-aes;84;83;82;82;88;81;84;89;82;82 08:29:51 INFO - PROCESS | 30830 | |11;stanford-crypto-ccm;138;140;135;147;132;135;136;139;170;133 08:29:51 INFO - PROCESS | 30830 | |12;stanford-crypto-pbkdf2;177;175;174;172;173;173;172;174;175;174 08:29:51 INFO - PROCESS | 30830 | |13;stanford-crypto-sha256-iterative;69;72;74;68;69;70;71;68;68;67 08:29:51 INFO - PROCESS | 30830 | __end_tp_report 08:29:51 INFO - PROCESS | 30830 | __start_cc_report 08:29:51 INFO - PROCESS | 30830 | _x_x_mozilla_cycle_collect,1916 08:29:51 INFO - PROCESS | 30830 | __end_cc_report 08:29:51 INFO - PROCESS | 30830 | __startTimestamp1474644591209__endTimestamp 08:29:51 INFO - PROCESS | 30830 | 08:29:51 INFO - PROCESS | 30830 | ------- Summary: start ------- 08:29:51 INFO - PROCESS | 30830 | Number of tests: 14 08:29:51 INFO - PROCESS | 30830 | 08:29:51 INFO - PROCESS | 30830 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:1.16 (1.0%) stddev-sans-first:1.05 08:29:51 INFO - PROCESS | 30830 | Values: 112.0 114.0 115.0 115.0 113.0 114.0 113.0 115.0 114.0 112.0 08:29:51 INFO - PROCESS | 30830 | 08:29:51 INFO - PROCESS | 30830 | [#1] audio-beat-detection Cycles:10 Average:136.70 Median:128.50 stddev:17.63 (13.7%) stddev-sans-first:17.26 08:29:51 INFO - PROCESS | 30830 | Values: 156.0 130.0 122.0 169.0 126.0 124.0 127.0 126.0 160.0 127.0 08:29:51 INFO - PROCESS | 30830 | 08:29:51 INFO - PROCESS | 30830 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 08:29:51 INFO - PROCESS | 30830 | Values: 161.0 161.0 162.0 161.0 161.0 160.0 161.0 161.0 161.0 161.0 08:29:51 INFO - PROCESS | 30830 | 08:29:51 INFO - PROCESS | 30830 | [#3] audio-fft Cycles:10 Average:82.60 Median:77.00 stddev:12.43 (16.1%) stddev-sans-first:12.95 08:29:51 INFO - PROCESS | 30830 | Values: 76.0 77.0 76.0 114.0 79.0 79.0 77.0 76.0 95.0 77.0 08:29:51 INFO - PROCESS | 30830 | 08:29:51 INFO - PROCESS | 30830 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:83.50 stddev:16.22 (19.4%) stddev-sans-first:16.86 08:29:51 INFO - PROCESS | 30830 | Values: 84.0 82.0 112.0 84.0 84.0 84.0 114.0 83.0 82.0 123.0 08:29:51 INFO - PROCESS | 30830 | 08:29:51 INFO - PROCESS | 30830 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.00 stddev:2.42 (2.1%) stddev-sans-first:2.50 08:29:51 INFO - PROCESS | 30830 | Values: 116.0 116.0 117.0 116.0 124.0 116.0 117.0 117.0 118.0 118.0 08:29:51 INFO - PROCESS | 30830 | 08:29:51 INFO - PROCESS | 30830 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 08:29:51 INFO - PROCESS | 30830 | Values: 147.0 147.0 147.0 146.0 147.0 146.0 147.0 146.0 146.0 146.0 08:29:51 INFO - PROCESS | 30830 | 08:29:51 INFO - PROCESS | 30830 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 08:29:51 INFO - PROCESS | 30830 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 08:29:51 INFO - PROCESS | 30830 | 08:29:51 INFO - PROCESS | 30830 | [#8] json-parse-financial Cycles:10 Average:63.50 Median:64.00 stddev:1.08 (1.7%) stddev-sans-first:1.00 08:29:51 INFO - PROCESS | 30830 | Values: 65.0 62.0 62.0 63.0 63.0 64.0 65.0 63.0 64.0 64.0 08:29:51 INFO - PROCESS | 30830 | 08:29:51 INFO - PROCESS | 30830 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 08:29:51 INFO - PROCESS | 30830 | Values: 66.0 66.0 65.0 66.0 66.0 66.0 66.0 66.0 65.0 66.0 08:29:51 INFO - PROCESS | 30830 | 08:29:51 INFO - PROCESS | 30830 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:83.50 stddev:2.71 (3.2%) stddev-sans-first:2.87 08:29:51 INFO - PROCESS | 30830 | Values: 84.0 83.0 82.0 82.0 88.0 81.0 84.0 89.0 82.0 82.0 08:29:51 INFO - PROCESS | 30830 | 08:29:51 INFO - PROCESS | 30830 | [#11] stanford-crypto-ccm Cycles:10 Average:140.50 Median:138.50 stddev:11.21 (8.1%) stddev-sans-first:11.85 08:29:51 INFO - PROCESS | 30830 | Values: 138.0 140.0 135.0 147.0 132.0 135.0 136.0 139.0 170.0 133.0 08:29:51 INFO - PROCESS | 30830 | 08:29:51 INFO - PROCESS | 30830 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.90 Median:174.00 stddev:1.52 (0.9%) stddev-sans-first:1.13 08:29:51 INFO - PROCESS | 30830 | Values: 177.0 175.0 174.0 172.0 173.0 173.0 172.0 174.0 175.0 174.0 08:29:51 INFO - PROCESS | 30830 | 08:29:51 INFO - PROCESS | 30830 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:69.50 stddev:2.17 (3.1%) stddev-sans-first:2.29 08:29:51 INFO - PROCESS | 30830 | Values: 69.0 72.0 74.0 68.0 69.0 70.0 71.0 68.0 68.0 67.0 08:29:51 INFO - PROCESS | 30830 | -------- Summary: end -------- 08:29:51 INFO - PROCESS | 30830 | 08:29:52 INFO - TEST-INFO | 30830: exit 0 08:29:52 INFO - TEST-OK | kraken | took 64797ms 08:29:52 INFO - SUITE-END | took 1185s 08:29:52 INFO - Completed test suite (00:19:46) 08:29:52 INFO - javascript benchmark 08:29:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2628.6057091436287, 2644.986775066124, 2681.7452342027514, 2682.396460796321, 2696.892124315026, 4614.700044497105, 4624.514425985265, 4753.976230118853, 4803.831865884699, 4890.535399137081, 4699.365585645936, 4705.647076469261, 4729.054189162164, 4755.120302743995, 4806.855794326167, 4347.760873151976, 4355.956440435602, 4407.691461597673, 4429.889252768674, 4443.0, 4481.865544033684, 4484.573965473275, 4485.032576593336, 4492.460904691426, 4504.414426124616, 4354.259775838115, 4436.933445998313, 4459.0413061192, 4472.932906006413, 4565.794539245725, 4373.125374925028, 4375.14684636496, 4418.977905110486, 4436.800343984529, 4441.733495990251, 4399.670024748125, 4403.493598236179, 4424.314231294123, 4468.084042771224, 4484.484284307314, 4749.073930583538, 4781.665283430161, 4804.447488538793, 4808.110499557558, 4854.296127061556, 4985.551300382983, 5010.849674509771, 5043.470435604282, 5079.288899554065, 5135.6148288878485, 5124.02643497738, 5126.128558145087, 5133.512316329943, 5179.559737422323, 5181.715005674687, 4770.61835053195, 4771.308160316735, 4775.21209000511, 4778.952210477851, 4841.225403935354, 5071.492850714899, 5094.312267843868, 5166.767495462713, 5241.371035475691, 5317.7341132943975, 4924.113659541245, 4935.925961110586, 4937.136001199776, 4998.750062496861, 5005.499450054966, 5006.974965125151, 5009.0, 5011.323471331397, 5019.14674505335, 5085.542301192911, 4929.408470983505, 4945.134601444733, 4959.90080198394, 4971.925421118686, 5021.422536408287, 4943.209086546135, 4972.776225069881, 5006.6495345325475, 5065.772040258197, 5070.062038522885, 4367.497737760198, 4367.519572846984, 4402.823887044547, 4425.137098265872, 4427.601515863524, 3808.181241033136, 3811.866584669523, 3820.56063552695, 3841.4621952926614, 3862.1117143057254, 4318.157959197926, 4355.80398882051, 4400.669949753717, 4401.823927042947, 4455.532169122261, 5062.392512898476, 5103.157978933508, 5117.513836185556, 5195.948040519622, 5201.5838732901275, 4399.054203346232, 4401.537838526909, 4452.933206001912, 4452.9554704453185, 4465.285554311295, 4619.260918253063, 4629.166749984967, 4632.8881068543305, 4635.119327327797, 4695.413073365829, 4705.600023997861, 4752.738599376929, 4795.832145874878, 4829.348038014823, 4844.95155048445, 5150.330457040561, 5195.6622819516615, 5196.948030519647, 5217.739113044257, 5256.89486210266, 4883.145449546386, 4886.780094895667, 4891.26631005352, 4899.730514821719, 4943.060818444484, 4933.975330123327, 4982.053409852117, 5046.520580544842, 5061.4179369373, 5062.797488100435, 5006.574441172541, 5023.748812559431, 5029.773660185374, 5053.84838454847, 5115.488451154854, 4920.114379411597, 4932.062908047459, 4932.358793356841, 4935.851924442272, 4993.126202914403, 4877.3903262092235, 4917.606591472745, 4928.482509336468, 4929.580985616263, 4989.201727723546, 4794.832180873653, 4813.542713442217, 4814.8796280093275, 4834.395700537433, 4885.65800393969, 4900.90198196027, 4921.680090794087, 4929.482404347492, 4933.451818717368, 4986.376702912136, 4769.0, 4772.331873537638, 4783.617310615212, 4790.969941462602, 4816.434658735855], "value": 4681.510616836831, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.6899270904648, 561.0238185557131, 566.1536003674507, 578.6585914310556, 582.664967643605, 27604.585931211048, 37898.62101378989, 38860.222795544076, 38903.61096389035, 43583.564164358344, 41024.38463423051, 41386.793066034705, 41407.378889316606, 41467.58532414675, 41562.0, 7223.855522889539, 7700.8459830803495, 7847.764567062969, 7857.607119643995, 7859.842803143933, 7326.157491888421, 7429.368503677194, 7432.739854105107, 9764.804703905918, 9952.701418957442, 10164.64423745169, 10236.795264094713, 10238.283320167591, 10239.385636861774, 10243.23175761817, 10084.798304033915, 10095.798084038352, 10115.848262276071, 10145.797084058315, 10171.898281017244, 9839.262055345878, 9902.603895844157, 9902.702918912444, 9913.75215619608, 9950.751231219205, 38508.229835403414, 38564.80717596422, 38747.41878871819, 38781.61218387808, 38872.222555549015, 2983.92617131094, 3132.530120481923, 3232.191952011997, 3245.318483118548, 3319.6348401675796, 28646.283842904093, 28783.56824647611, 29134.70865291341, 29501.409971800444, 30605.38789224203, 3304.3556506481245, 3374.578177727784, 3380.7802492837886, 3415.4706020566605, 3417.8120203388803, 256921.0, 257225.0, 257983.0, 258488.7075564629, 258702.70648646823, 30451.670957582333, 31523.0, 50472.242916356285, 50719.492805072216, 50732.926707328974, 32878.506822397685, 33088.0, 33191.66808331886, 33208.1697957553, 33327.83336083352, 13312.334383280991, 13427.664308392368, 13463.865361346458, 13466.259355735529, 13472.461101555828, 10826.783464330827, 10885.23803333759, 10954.39750813697, 11022.118230541537, 11038.061764749926, 7108.573485590778, 7315.63421828917, 7497.62511874415, 7770.41721870862, 7794.10367807698, 3068.70847269509, 3116.8909088181804, 3134.357456721367, 3166.0501849445072, 3173.8730450782173, 794.8767940969159, 878.4026861733954, 882.223643193998, 962.0523784072683, 971.5530855806409, 26364.60453093205, 27864.0, 28247.138860314797, 28546.714532854407, 28650.856745716137, 950.8621249918862, 993.7366597851575, 1006.4665727164614, 1037.1547189040907, 1045.5660900726114, 14443.133411995314, 14953.40186392532, 15074.698506030038, 15364.846351536566, 15414.768778468331, 119315.0, 120440.0, 120638.0, 120817.39591302162, 121180.39409802895, 48997.51002490001, 49355.50644493509, 49419.50580494221, 49420.0, 49467.50532494629, 1066.7919755647574, 1093.8577984861918, 1140.5893878203674, 1158.5250047480492, 1175.0305997552055, 25310.367240819127, 29062.27344316409, 29763.55354669725, 29870.980319624436, 30004.554996633124, 41462.1707565853, 41951.37072943847, 41990.79004604957, 42009.57990420057, 42059.7897010513, 303295.0, 303979.0, 304079.0, 305390.0, 306388.0, 24061.879690601436, 24545.386365341008, 24698.50602987966, 25289.873550632867, 25751.0, 42328.1534369317, 42604.36093458663, 42649.0, 42813.0, 43020.35469467898, 34990.47514287237, 35055.47416788699, 35593.288134237686, 35639.64360356363, 35661.28677426489, 35799.82100089483, 35813.28373432464, 36063.0, 36319.0, 36341.45487817632, 34804.82597586996, 35158.12104697301, 35456.82271588626, 35465.64534354623, 36076.45885311775, 30984.53523197199, 32940.1764955878, 33173.50239746358, 33180.83409583033, 33394.666053339155, 21495.0, 21699.783002170407, 21835.67246491272, 21874.0, 22194.66707999349], "value": 16115.086861033478, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.4724208171907, 368.29839156407036, 377.49604278288484, 379.37024539264826, 393.81490699371284, 12297.631071067872, 12434.0, 13251.469941202364, 16127.677446451064, 16974.236159372827, 16301.429449969253, 16723.916380418083, 17143.914280428613, 17222.483325500223, 17330.220140093694, 4761.333413322138, 5063.645544811865, 5078.796848126089, 5080.339555857752, 5092.465291144432, 3704.3887758519813, 3897.824597893102, 5038.748062596856, 5117.667351622133, 5123.5388815006645, 5684.2326285951285, 5900.940990590082, 5941.584089113764, 6057.454829065383, 6065.575409721321, 5698.458646428583, 5874.6181498202905, 5905.084711869667, 6030.608010479326, 6036.607620504675, 5210.270562121306, 5212.192110222922, 5214.687118772886, 5214.791408343662, 5215.687058776485, 19604.901975490033, 19773.307934222375, 20376.184952601878, 20460.79539204604, 20704.58590828175, 1596.5529651697543, 1914.0716752375088, 1950.882947023169, 1958.079702539804, 1994.6110508450859, 9025.368224224307, 9224.446533207962, 9623.0, 11468.942655286754, 13629.659258518517, 1743.1458585293242, 1788.3561917709615, 1792.3010026089705, 1813.9841688654396, 1820.8452281556083, 63427.682861585396, 65427.99999999953, 66397.66801166012, 68115.0, 70045.29954700438, 9668.903310966942, 9832.557534910804, 9853.704388868346, 9961.402315860927, 10143.18854491639, 13394.531191408254, 13396.93301533486, 13402.463901444027, 13404.128731632607, 13428.395722192525, 6897.310268973062, 7030.683619237147, 7089.539179953286, 7275.345218930322, 7283.2716728327805, 6685.431738302202, 6703.497237707192, 6718.462522998148, 6911.861762764716, 6913.654317284116, 4151.398047283187, 4221.514525829569, 4296.4414626098405, 4306.9663280813, 4319.6889664029595, 1690.6027083635336, 1751.1856986501339, 1760.0935518208132, 1796.2365994452305, 1802.6665066962653, 814.608987685914, 836.1680128272408, 883.8995450663964, 885.2784980241083, 942.7690215897012, 15854.44509442187, 16525.25636346367, 16739.66520669604, 16790.16049197535, 17394.565135871704, 793.2900054451234, 822.3380178955879, 824.1799409587499, 834.61190546395, 863.9265662418765, 9100.772480687903, 9626.422414655142, 9654.613815447303, 9655.22758179344, 9712.805743885225, 267948.0, 351950.0, 354173.45826541405, 354417.0, 355966.0, 83889.58055209684, 83975.0, 84713.15286847176, 84778.0, 87264.1273587256, 927.684587240328, 952.3286083311249, 953.0755167487526, 954.3939598354956, 956.8182045411489, 15174.31715572824, 15363.846361536689, 15467.613309667347, 15845.841541584437, 16211.189440528162, 30634.84682576573, 34102.317953641286, 37323.81338093292, 38170.61829381782, 38987.6101238984, 51521.0, 51754.48245517497, 51936.74031629818, 52012.47987520076, 54270.005498075356, 7429.8142546436775, 7507.361874240751, 7671.53970761756, 7879.645415956181, 7986.321162701235, 11473.311601303949, 11565.132615053737, 11575.826362604736, 11643.59247426336, 11745.941270293593, 10087.478130467383, 10241.23190760681, 10408.750949886062, 10494.265401421828, 10919.454027298445, 10224.59101635956, 10278.434686092336, 10430.68707938763, 10507.47462626881, 10573.4713264338, 10200.0, 10293.897061029294, 10461.9476902615, 10513.737156571147, 10859.457027148768, 7381.630918453949, 7462.253774622712, 7490.775276741707, 7517.962410187914, 7537.54774713519, 10155.898441015495, 10166.339187952759, 10458.790824183321, 10624.096951758878, 11096.889031109586], "value": 8152.269935502635, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1229.772492088963, 1351.1892864281429, 1377.3113443278362, 1427.8786303164231, 1702.812690604034, 6981.6509174541325, 7545.358644515216, 7680.078390593137, 7941.841163176748, 7943.404244681643, 8003.239692229244, 8097.797555061126, 8099.838003239932, 8101.878471822927, 8106.797330066736, 2196.1435040334322, 2209.3371988403496, 2215.9113635454564, 2217.800397964183, 2228.3649159989404, 2157.7087093242367, 2168.035224325176, 2188.1794327127327, 2198.1756841184556, 2200.526886719355, 2151.3868547463976, 2157.9892100539473, 2176.542925985537, 2180.9127634894667, 2199.483121466454, 2129.169623846701, 2129.872207667537, 2134.2103421733905, 2151.0320355839935, 2154.1598776477185, 2055.7738648748627, 2101.894905254731, 2102.57948410317, 2103.8001389867936, 2108.968365474519, 7934.880976785353, 7951.0, 8025.3178479829285, 8028.397870159762, 8041.758747237593, 4673.649476289258, 4831.830885918976, 4831.975840120812, 4891.608671306287, 4904.362432883738, 2826.590144429046, 3001.309698769295, 3013.367192889496, 3027.16752892954, 3056.9541456878164, 923.9168474837297, 928.9442633441947, 938.5823308627663, 955.1451450951429, 955.6034245787989, 10942.671719848417, 11029.0, 11060.115190784718, 11060.115190784798, 11068.114550835913, 4099.323611604112, 4103.958960410358, 4188.602082802129, 4240.957590424118, 4300.290452075373, 8192.221738934792, 8308.5430301334, 8312.792180195544, 8315.00219973607, 8315.04376996641, 4681.016986432819, 4681.297805329228, 4686.835960741358, 4688.156131896223, 4688.718676879398, 3676.17286110623, 3874.1864208516527, 4001.7198796084576, 4322.956770432318, 4348.717333373384, 3191.29265842773, 3547.5565554305713, 3548.2371290172737, 3549.048023587017, 3552.573691157026, 1037.9377237365782, 1041.3023274406166, 1058.1534772182224, 1058.9894101059044, 1063.4310643805527, 708.6492186367781, 818.6766227340167, 819.3445243804932, 840.1766269056359, 841.5035129273758, 5047.217681259411, 5166.560842328444, 5208.192730126761, 5213.635045546851, 5404.675719456766, 398.62330098057635, 400.5933977013334, 405.17546792277574, 412.82867609941536, 426.08179373450264, 3505.4391297392294, 3595.0, 3831.7700937943814, 3879.4374815652136, 3928.941065884014, 9674.467904265333, 10058.59765609382, 10194.337368071052, 10216.948915255376, 10221.540030698636, 10125.848112278174, 10194.082532571956, 10199.847002294971, 10202.132818710492, 10210.744731381626, 7437.1447283562, 7497.587632680146, 7539.585322807188, 7591.962040189764, 7650.081990161105, 5315.441878602691, 5321.255024296524, 5336.439673834191, 5410.101252171873, 5510.586705997146, 8969.641214351353, 9105.863412048957, 9176.95411522938, 9204.447733136034, 9215.44707317563, 8249.092599814136, 9053.77365565866, 9240.0, 9263.490508022123, 9305.488198149167, 6336.239651241881, 6677.399034086956, 6865.176178858569, 6899.75850845218, 7033.050538177281, 7608.923910760822, 7643.503172293783, 7671.578063206354, 7679.539227646359, 7727.768166955, 6753.831154221184, 6806.251312355538, 6806.387425131762, 6806.76176333826, 6816.829579260559, 6727.562708423937, 6785.6946437411425, 6810.9318906810295, 6987.336203060701, 7030.894536581853, 6435.710393032231, 6441.3880681335195, 6471.644059576768, 6487.124238227779, 6487.513436492376, 4344.782760861881, 4442.178197033559, 4506.729596224237, 4537.773111344353, 4562.65780066503, 4488.0, 4551.340055691972, 4567.931481027721, 4569.497355290849, 4748.596369308648], "value": 4064.6050274169816, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.6878695860636, 282.60858710685704, 284.88177406376343, 286.9913902582922, 300.4951681175627, 4843.80624775009, 4871.902561948759, 4881.341018962444, 4893.192623217169, 4896.975515122419, 4588.54114588541, 4687.414073240845, 4756.262779269219, 4797.424309082906, 4867.342908707324, 3755.380362240227, 3759.718021148411, 3771.4531392948006, 3773.52830896138, 3774.8109345556063, 3752.287065457568, 3760.1539653578, 3777.527809023872, 3778.9433158502643, 3784.829682664287, 3523.330567192238, 3542.3977923752896, 3697.611750766171, 3707.388280933643, 3768.2651882882847, 3752.8123593820337, 3758.8120593970466, 3768.8680896168776, 3771.15149091455, 3773.905652358699, 3302.9009129725905, 3311.0563489405404, 3312.420326442863, 3314.2211580278617, 3315.419801534746, 4609.312549960018, 4693.6479764017495, 4714.481407045222, 4726.243800991825, 4736.384270044872, 4165.83336666533, 4223.260929337384, 4228.873133805991, 4240.151969606091, 4245.915081698379, 4943.752812359367, 4965.354503914468, 4975.825846095406, 4988.625853060998, 4998.600111991068, 3581.4627805829073, 3584.444411116281, 3591.5510561179854, 3593.2813437312643, 3594.7663401878795, 5100.591952643779, 5161.251618515332, 5216.895662086775, 5235.869103272448, 5236.7119808410525, 3644.890653280406, 3649.9270014600093, 3653.4337177737493, 3659.341318562684, 3660.3411385950253, 3711.9072023199637, 3713.424419215026, 3724.795136267477, 3725.403935370328, 3730.850765969385, 4223.21870453967, 4228.667969589569, 4248.596383343577, 4249.128928569636, 4249.490061192615, 4810.39870016248, 5066.645334826527, 5080.0, 5080.74596270185, 5087.516685914832, 1240.1938739819009, 1244.966677657542, 1248.806435002576, 1252.5803855708439, 1252.6367353467392, 784.7724159993538, 795.323974621567, 798.504926945286, 810.9959450202829, 830.9086000539936, 4417.602415782595, 4420.624246938982, 4424.247877860771, 4425.3140763181755, 4431.158079964796, 5104.897902041938, 5125.0, 5130.923036154386, 5140.742962851842, 5147.716875571805, 4330.895621616468, 4393.264660459165, 4395.626371758436, 4415.337699345124, 4443.400140980991, 2722.2105589379253, 2748.2548581650394, 2755.9862200689267, 2756.379814541712, 2762.4392218396542, 4878.829240976549, 4890.364252647133, 4890.975545122323, 4894.877628059327, 4919.310517112166, 5078.0, 5193.740312984336, 5245.134552798745, 5259.289995850511, 5260.133227391005, 4866.0, 4869.586085182728, 4889.462159162489, 4892.217245240816, 4897.167481528078, 5105.744712764273, 5124.666896651705, 5127.4872512748425, 5129.384473863161, 5133.794648214179, 4853.0, 5033.345665063518, 5034.521720436553, 5149.150390185578, 5156.303898973741, 5019.974900125476, 5026.52248036436, 5030.748462576783, 5034.622403319839, 5048.848534543969, 3651.7626354286886, 3668.734286671094, 3672.1554042570892, 3673.9448908265863, 3675.7243206760136, 5123.410807757155, 5202.0116177926075, 5217.2434996925995, 5288.206768984683, 5301.125314323093, 5096.006278775603, 5115.386153661584, 5116.465060481766, 5119.539241468136, 5120.48795120485, 5106.004329155779, 5110.71891045996, 5121.334226550524, 5124.487551244845, 5129.948700512947, 4784.952150478451, 5016.322796422436, 5040.243963405518, 5047.596192304681, 5048.242763585492, 4879.219324907997, 4982.950170498394, 5008.549230569266, 5140.665856719302, 5145.176771716508, 4973.751312434291, 4990.976849745721, 4994.850154495371, 5009.373828271466, 5016.799328026838], "value": 3784.137242031156, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [644.8387903024244, 646.1115965547373, 673.8113328268083, 710.0414440505318, 742.5841528743904, 12675.112742108056, 13820.792688109686, 13847.376868040938, 13847.584572462816, 13877.16736995781, 12303.0, 12330.383480825967, 12483.063770217248, 12506.062045346589, 12620.432080556375, 625.4058644287921, 643.8068579426177, 736.2269616902258, 741.5550669598252, 770.9961450192741, 764.4534158076974, 776.1191048160322, 776.8407476467339, 776.8756998880181, 777.059757693192, 824.11819353292, 825.781167990483, 825.9876101858476, 825.9876101858476, 826.1985873702499, 654.2868273581819, 675.3179288918179, 799.5562462833125, 821.7863355527576, 823.1850468036661, 597.3459062326746, 601.21541388488, 601.2184160591214, 601.3565484931125, 601.8555546668767, 12598.622041338775, 12600.68498287541, 12604.369781510888, 12604.432800523999, 12616.810747838697, 12516.81224781629, 12723.491060357575, 13132.803007954888, 13305.467781288833, 13522.93238533801, 11694.0, 11751.882481175164, 11923.344216068113, 12093.45579448927, 12520.81218781719, 4148.124681341879, 4195.0, 4209.515905670826, 4246.171996460692, 4346.043870348518, 66497.99999999952, 67443.0, 68026.65986670085, 68226.65886670584, 68284.0, 10088.344257623232, 10104.69685909424, 10126.341787783771, 10140.239482038876, 10295.485225738683, 17231.310747569958, 17897.284108635507, 17909.373171938918, 19454.8054519453, 19528.121234544196, 6833.453323734089, 6909.378155965987, 7046.541974771623, 7114.21743608213, 7129.89305160423, 3538.8230588470988, 3782.0922978484964, 3806.8477260909253, 3820.84716611338, 3875.5736868944396, 2929.5605659151297, 3065.4635438798123, 3072.293372524332, 3076.6923307669504, 3087.6449208340878, 513.8047541934042, 518.9948100519022, 524.6432425950314, 531.7926008856549, 533.9813106541252, 560.6019725994508, 614.1708693264147, 617.3147805935408, 622.5704264057877, 625.4402309932585, 8465.534395608302, 8499.138063798291, 8579.957100214584, 8797.868031979526, 8956.328275379372, 560.6916196092133, 572.7794799002331, 575.4044563876367, 581.5260562641433, 595.7378753348513, 3914.980425097913, 4229.302165142779, 4240.872773816729, 4254.7659878706345, 4444.644428445717, 57951.0, 86124.0, 98845.50577247211, 103905.48047259715, 106018.46990764997, 85805.57097214473, 87606.0, 87949.56025219832, 88695.0, 90067.0, 76252.0, 77475.0, 77496.0, 79193.0, 79684.20315796883, 7963.203679632222, 8035.397345199017, 8042.718504852302, 8057.0, 8165.274952628588, 45860.770696146305, 47407.76296118497, 47928.0, 48083.27875081806, 48424.757876210395, 62573.06140407988, 63049.0, 68717.0, 69015.65492172507, 69834.65082674554, 9725.270604704534, 9844.852327215242, 9898.059684329977, 10225.181985441295, 10537.315074520131, 11103.5558577656, 11205.383703896365, 11452.14108941816, 11614.419279035845, 11712.590059347882, 10165.695029149138, 10454.947725261325, 10619.575216991234, 10778.784424311627, 11197.944010279896, 10689.0, 10734.463276835972, 11137.164712646421, 11252.493637786156, 11509.827352589551, 10501.737456563342, 10673.519691613741, 10689.839652405375, 11236.381998990135, 11260.38067906273, 8634.78413039654, 8867.68963086289, 9210.263178945803, 9295.024022477543, 9423.151916327564, 9279.814403711753, 9610.471424071464, 9728.854067189139, 9734.269929755439, 9789.951050244988], "value": 6574.540224864291, "unit": "score"}], "name": "dromaeo_css", "value": 6294.5654156716455, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 115.0, 115.0, 113.0, 114.0, 113.0, 115.0, 114.0, 112.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 130.0, 122.0, 169.0, 126.0, 124.0, 127.0, 126.0, 160.0, 127.0], "value": 136.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 161.0, 160.0, 161.0, 161.0, 161.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 114.0, 79.0, 79.0, 77.0, 76.0, 95.0, 77.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 112.0, 84.0, 84.0, 84.0, 114.0, 83.0, 82.0, 123.0], "value": 93.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 116.0, 124.0, 116.0, 117.0, 117.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 62.0, 63.0, 63.0, 64.0, 65.0, 63.0, 64.0, 64.0], "value": 63.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 66.0, 66.0, 66.0, 66.0, 65.0, 66.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 82.0, 82.0, 88.0, 81.0, 84.0, 89.0, 82.0, 82.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 140.0, 135.0, 147.0, 132.0, 135.0, 136.0, 139.0, 170.0, 133.0], "value": 140.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 175.0, 174.0, 172.0, 173.0, 173.0, 172.0, 174.0, 175.0, 174.0], "value": 173.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 74.0, 68.0, 69.0, 70.0, 71.0, 68.0, 68.0, 67.0], "value": 69.6, "unit": "score"}], "name": "kraken", "value": 1543.2, "alertThreshold": 2.0}]} 08:29:52 INFO - Return code: 0 08:29:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:29:53 INFO - # TBPL SUCCESS # 08:29:53 INFO - Running post-action listener: _resource_record_post_action 08:29:53 INFO - [mozharness: 2016-09-23 15:29:53.015318Z] Finished run-tests step (success) 08:29:53 INFO - Running post-run listener: _resource_record_post_run 08:29:53 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 390754304; Read time: 16; Write time: 239536 08:29:53 INFO - TinderboxPrint: CPU usage
13.0% 08:29:53 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 08:29:53 INFO - TinderboxPrint: I/O write bytes / time
390,754,304 / 239,536 08:29:53 INFO - TinderboxPrint: CPU idle
8,342.9 (87.0%) 08:29:53 INFO - TinderboxPrint: CPU user
1,201.5 (12.5%) 08:29:53 INFO - TinderboxPrint: Swap in / out
0 / 0 08:29:53 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99753984; Read time: 0; Write time: 88720 08:29:53 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 291000320; Read time: 0; Write time: 150816 08:29:53 INFO - Running post-run listener: _upload_blobber_files 08:29:53 INFO - Blob upload gear active. 08:29:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:29:53 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:29:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:29:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:29:54 INFO - (blobuploader) - INFO - Open directory for files ... 08:29:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:29:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:29:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:55 INFO - (blobuploader) - INFO - Done attempting. 08:29:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:29:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:29:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:58 INFO - (blobuploader) - INFO - Done attempting. 08:29:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:29:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:29:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:59 INFO - (blobuploader) - INFO - Done attempting. 08:29:59 INFO - (blobuploader) - INFO - Iteration through files over. 08:29:59 INFO - Return code: 0 08:29:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:29:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:29:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eee38d677eadc46e8dfb5223af316c9651534ff7ad579cdff120ee2d72a779a44cafbc4d0f701d004892ef27a3ed5c6dd917b4b69629fe9da08f11c93301e452", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9c7beb2d91f1f2abc05405581ae3a5e60d18c7c9ec1d05e95f47baa0453a5e3987a433a145b3c25d256318e17cd7dc6e64e0758ad3dcc97355416251d4c5fcc6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9046fea7eab39e315842698ac3d30a32dedcc9b38c0ab99b9d0af36be35ef0946349ea9a93f3135b80a90048253398307b5e378b2aedf073cb5ccc3bead124c8"} 08:29:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:29:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:29:59 INFO - Contents: 08:29:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eee38d677eadc46e8dfb5223af316c9651534ff7ad579cdff120ee2d72a779a44cafbc4d0f701d004892ef27a3ed5c6dd917b4b69629fe9da08f11c93301e452", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9c7beb2d91f1f2abc05405581ae3a5e60d18c7c9ec1d05e95f47baa0453a5e3987a433a145b3c25d256318e17cd7dc6e64e0758ad3dcc97355416251d4c5fcc6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9046fea7eab39e315842698ac3d30a32dedcc9b38c0ab99b9d0af36be35ef0946349ea9a93f3135b80a90048253398307b5e378b2aedf073cb5ccc3bead124c8"} 08:29:59 INFO - Running post-run listener: copy_logs_to_upload_dir 08:29:59 INFO - Copying logs to upload dir... 08:29:59 INFO - mkdir: /builds/slave/test/build/upload/logs 08:29:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.105485 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-09-23 08:29:58.946289) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 08:29:58.950100) ========= 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=ed14279e38b05397cf4aa391000001a4-1474641296.502216-668379515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eee38d677eadc46e8dfb5223af316c9651534ff7ad579cdff120ee2d72a779a44cafbc4d0f701d004892ef27a3ed5c6dd917b4b69629fe9da08f11c93301e452", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9c7beb2d91f1f2abc05405581ae3a5e60d18c7c9ec1d05e95f47baa0453a5e3987a433a145b3c25d256318e17cd7dc6e64e0758ad3dcc97355416251d4c5fcc6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9046fea7eab39e315842698ac3d30a32dedcc9b38c0ab99b9d0af36be35ef0946349ea9a93f3135b80a90048253398307b5e378b2aedf073cb5ccc3bead124c8"} build_url:https://queue.taskcluster.net/v1/task/KUUmQOFvRpe85Vs5DR4wTA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011367 build_url: 'https://queue.taskcluster.net/v1/task/KUUmQOFvRpe85Vs5DR4wTA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eee38d677eadc46e8dfb5223af316c9651534ff7ad579cdff120ee2d72a779a44cafbc4d0f701d004892ef27a3ed5c6dd917b4b69629fe9da08f11c93301e452", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9c7beb2d91f1f2abc05405581ae3a5e60d18c7c9ec1d05e95f47baa0453a5e3987a433a145b3c25d256318e17cd7dc6e64e0758ad3dcc97355416251d4c5fcc6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9046fea7eab39e315842698ac3d30a32dedcc9b38c0ab99b9d0af36be35ef0946349ea9a93f3135b80a90048253398307b5e378b2aedf073cb5ccc3bead124c8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 08:29:58.975772) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 08:29:58.976113) ========= 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=ed14279e38b05397cf4aa391000001a4-1474641296.502216-668379515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004403 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 08:29:59.058762) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 08:29:59.059474) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 08:29:59.059856) ========= ========= Total master_lag: 0.16 =========