builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-043 starttime: 1474428486.99 results: success (0) buildid: 20160920185816 builduid: 3d396a4b0c544f25a23bff096d4807a6 revision: bf78a4c31c1c85b17006883f47282bc6c40fed82 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-20 20:28:06.991297) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-20 20:28:06.991757) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-20 20:28:06.992029) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-20 20:28:07.006794) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 20:28:07.007167) ========= 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=d2a8c569965ab8367867b893000001a1-1474428486.435408-1588921463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-20 20:28:07-- 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% 42.6M=0s 2016-09-20 20:28:07 (42.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095554 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 20:28:07.116924) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 20:28:07.117234) ========= 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=d2a8c569965ab8367867b893000001a1-1474428486.435408-1588921463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015778 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 20:28:07.166766) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 20:28:07.167149) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bf78a4c31c1c85b17006883f47282bc6c40fed82 --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 bf78a4c31c1c85b17006883f47282bc6c40fed82 --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=d2a8c569965ab8367867b893000001a1-1474428486.435408-1588921463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-20 20:28:07,319 truncating revision to first 12 chars 2016-09-20 20:28:07,319 Setting DEBUG logging. 2016-09-20 20:28:07,319 attempt 1/10 2016-09-20 20:28:07,319 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bf78a4c31c1c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-20 20:28:07,669 unpacking tar archive at: fx-team-bf78a4c31c1c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.791963 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 20:28:07.971818) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-20 20:28:07.972136) ========= script_repo_revision: bf78a4c31c1c85b17006883f47282bc6c40fed82 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-20 20:28:07.972542) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-20 20:28:07.972833) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-20 20:28:07.980188) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-09-20 20:28:07.980451) ========= /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=d2a8c569965ab8367867b893000001a1-1474428486.435408-1588921463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:28:08 INFO - MultiFileLogger online at 20160920 20:28:08 in /builds/slave/test 20:28:08 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 20:28:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:28:08 INFO - {'append_to_log': False, 20:28:08 INFO - 'base_work_dir': '/builds/slave/test', 20:28:08 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 20:28:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:28:08 INFO - 'branch': 'Fx-Team-Non-PGO', 20:28:08 INFO - 'buildbot_json_path': 'buildprops.json', 20:28:08 INFO - 'config_files': ('talos/linux_config.py',), 20:28:08 INFO - 'default_actions': ('clobber', 20:28:08 INFO - 'read-buildbot-config', 20:28:08 INFO - 'download-and-extract', 20:28:08 INFO - 'populate-webroot', 20:28:08 INFO - 'create-virtualenv', 20:28:08 INFO - 'install', 20:28:08 INFO - 'run-tests'), 20:28:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:28:08 INFO - 'download_minidump_stackwalk': True, 20:28:08 INFO - 'download_symbols': 'ondemand', 20:28:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:28:08 INFO - 'tooltool.py': '/tools/tooltool.py', 20:28:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:28:08 INFO - '/tools/misc-python/virtualenv.py')}, 20:28:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:28:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:28:08 INFO - 'installer_path': 'installer.exe', 20:28:08 INFO - 'log_level': 'info', 20:28:08 INFO - 'log_name': 'talos', 20:28:08 INFO - 'log_to_console': True, 20:28:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:28:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:28:08 INFO - 'opt_config_files': (), 20:28:08 INFO - 'pip_index': False, 20:28:08 INFO - 'sps_profile': False, 20:28:08 INFO - 'sps_profile_interval': 0, 20:28:08 INFO - 'suite': 'dromaeojs', 20:28:08 INFO - 'system_bits': '32', 20:28:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:28:08 INFO - 'title': 'talos-linux64-ix-043', 20:28:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:28:08 INFO - 'use_talos_json': True, 20:28:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:28:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:28:08 INFO - 'work_dir': 'build'} 20:28:08 INFO - [mozharness: 2016-09-21 03:28:08.222717Z] Running clobber step. 20:28:08 INFO - Running pre-action listener: _resource_record_pre_action 20:28:08 INFO - Running main action method: clobber 20:28:08 INFO - rmtree: /builds/slave/test/build 20:28:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:28:09 INFO - Running post-action listener: _resource_record_post_action 20:28:09 INFO - [mozharness: 2016-09-21 03:28:09.224517Z] Finished clobber step (success) 20:28:09 INFO - [mozharness: 2016-09-21 03:28:09.224616Z] Running read-buildbot-config step. 20:28:09 INFO - Running pre-action listener: _resource_record_pre_action 20:28:09 INFO - Running main action method: read_buildbot_config 20:28:09 INFO - Using buildbot properties: 20:28:09 INFO - { 20:28:09 INFO - "project": "", 20:28:09 INFO - "product": "firefox", 20:28:09 INFO - "script_repo_revision": "production", 20:28:09 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:28:09 INFO - "repository": "", 20:28:09 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 20:28:09 INFO - "buildid": "20160920185816", 20:28:09 INFO - "pgo_build": "False", 20:28:09 INFO - "basedir": "/builds/slave/test", 20:28:09 INFO - "buildnumber": 1943, 20:28:09 INFO - "slavename": "talos-linux64-ix-043", 20:28:09 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:28:09 INFO - "platform": "ubuntu64_hw", 20:28:09 INFO - "scheduler": "tests-fx-team-linux64-talos", 20:28:09 INFO - "branch": "fx-team", 20:28:09 INFO - "repo_path": "integration/fx-team", 20:28:09 INFO - "revision": "bf78a4c31c1c85b17006883f47282bc6c40fed82", 20:28:09 INFO - "stage_platform": "linux64", 20:28:09 INFO - "builduid": "3d396a4b0c544f25a23bff096d4807a6", 20:28:09 INFO - "slavebuilddir": "test" 20:28:09 INFO - } 20:28:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/HUbAgtE-T6ilh0vonUHStg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 20:28:09 INFO - Running post-action listener: _resource_record_post_action 20:28:09 INFO - [mozharness: 2016-09-21 03:28:09.227066Z] Finished read-buildbot-config step (success) 20:28:09 INFO - [mozharness: 2016-09-21 03:28:09.227156Z] Running download-and-extract step. 20:28:09 INFO - Running pre-action listener: _resource_record_pre_action 20:28:09 INFO - Running main action method: download_and_extract 20:28:09 INFO - mkdir: /builds/slave/test/build/tests 20:28:09 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')]} 20:28:09 INFO - trying https://queue.taskcluster.net/v1/task/HUbAgtE-T6ilh0vonUHStg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:28:09 INFO - Downloading https://queue.taskcluster.net/v1/task/HUbAgtE-T6ilh0vonUHStg/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 20:28:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HUbAgtE-T6ilh0vonUHStg/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 20:28:09 INFO - Downloaded 1361 bytes. 20:28:09 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:28:09 INFO - Using the following test package requirements: 20:28:09 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 20:28:09 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:28:09 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:28:09 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:28:09 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:28:09 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:28:09 INFO - u'jsshell-linux-x86_64.zip'], 20:28:09 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:28:09 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:28:09 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 20:28:09 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:28:09 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:28:09 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:28:09 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:28:09 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:28:09 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:28:09 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:28:09 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:28:09 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:28:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HUbAgtE-T6ilh0vonUHStg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 20:28:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HUbAgtE-T6ilh0vonUHStg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:28:09 INFO - Fetch https://queue.taskcluster.net/v1/task/HUbAgtE-T6ilh0vonUHStg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:28:10 INFO - Expected file size: 20369760 20:28:14 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 20:28:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HUbAgtE-T6ilh0vonUHStg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 20:28:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HUbAgtE-T6ilh0vonUHStg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:28:14 INFO - Fetch https://queue.taskcluster.net/v1/task/HUbAgtE-T6ilh0vonUHStg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:28:15 INFO - Expected file size: 20369760 20:28:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HUbAgtE-T6ilh0vonUHStg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 20:28:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HUbAgtE-T6ilh0vonUHStg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:28:19 INFO - Fetch https://queue.taskcluster.net/v1/task/HUbAgtE-T6ilh0vonUHStg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 20:28:20 INFO - Expected file size: 14414059 20:28:20 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')]} 20:28:20 INFO - trying https://queue.taskcluster.net/v1/task/HUbAgtE-T6ilh0vonUHStg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:28:20 INFO - Downloading https://queue.taskcluster.net/v1/task/HUbAgtE-T6ilh0vonUHStg/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 20:28:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HUbAgtE-T6ilh0vonUHStg/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 20:28:21 INFO - Downloaded 55599666 bytes. 20:28:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HUbAgtE-T6ilh0vonUHStg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:28:21 INFO - mkdir: /builds/slave/test/properties 20:28:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:28:21 INFO - Writing to file /builds/slave/test/properties/build_url 20:28:21 INFO - Contents: 20:28:21 INFO - build_url:https://queue.taskcluster.net/v1/task/HUbAgtE-T6ilh0vonUHStg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:28:22 INFO - Running post-action listener: _resource_record_post_action 20:28:22 INFO - Running post-action listener: set_extra_try_arguments 20:28:22 INFO - [mozharness: 2016-09-21 03:28:22.551126Z] Finished download-and-extract step (success) 20:28:22 INFO - [mozharness: 2016-09-21 03:28:22.551354Z] Running populate-webroot step. 20:28:22 INFO - Running pre-action listener: _resource_record_pre_action 20:28:22 INFO - Running main action method: populate_webroot 20:28:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:28:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:28:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:28:22 INFO - '--tppagecycles', 20:28:22 INFO - '7'], 20:28:22 INFO - 'tests': ['tsvgm']}}, 20:28:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:28:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:28:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:28:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:28:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:28:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:28:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:22 INFO - 'talos_options': ['--disable-e10s'], 20:28:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:28:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:28:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:22 INFO - 'talos_options': ['--disable-e10s'], 20:28:22 INFO - 'tests': ['damp', 'tps']}, 20:28:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:22 INFO - 'tests': ['damp', 'tps']}, 20:28:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:28:22 INFO - 'tests': ['dromaeo_dom']}, 20:28:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:28:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:28:22 INFO - 'tests': ['basic_compositor_video']}, 20:28:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:28:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:28:22 INFO - 'tests': ['a11yr', 20:28:22 INFO - 'ts_paint', 20:28:22 INFO - 'tpaint', 20:28:22 INFO - 'sessionrestore', 20:28:22 INFO - 'sessionrestore_no_auto_restore', 20:28:22 INFO - 'tabpaint']}, 20:28:22 INFO - 'other-e10s': {'tests': ['a11yr', 20:28:22 INFO - 'ts_paint', 20:28:22 INFO - 'tpaint', 20:28:22 INFO - 'sessionrestore', 20:28:22 INFO - 'sessionrestore_no_auto_restore', 20:28:22 INFO - 'tabpaint']}, 20:28:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:28:22 INFO - 'ts_paint', 20:28:22 INFO - 'tpaint', 20:28:22 INFO - 'sessionrestore', 20:28:22 INFO - 'sessionrestore_no_auto_restore', 20:28:22 INFO - 'tabpaint']}, 20:28:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:28:22 INFO - 'ts_paint', 20:28:22 INFO - 'tpaint', 20:28:22 INFO - 'sessionrestore', 20:28:22 INFO - 'sessionrestore_no_auto_restore', 20:28:22 INFO - 'tabpaint']}, 20:28:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:28:22 INFO - 'tests': ['a11yr', 20:28:22 INFO - 'ts_paint', 20:28:22 INFO - 'tpaint', 20:28:22 INFO - 'sessionrestore', 20:28:22 INFO - 'sessionrestore_no_auto_restore', 20:28:22 INFO - 'tabpaint']}, 20:28:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:28:22 INFO - 'tests': ['a11yr', 20:28:22 INFO - 'ts_paint', 20:28:22 INFO - 'tpaint', 20:28:22 INFO - 'sessionrestore', 20:28:22 INFO - 'sessionrestore_no_auto_restore', 20:28:22 INFO - 'tabpaint']}, 20:28:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:28:22 INFO - 'tests': ['tsvgx', 20:28:22 INFO - 'tsvgr_opacity', 20:28:22 INFO - 'tart', 20:28:22 INFO - 'tscrollx', 20:28:22 INFO - 'cart']}, 20:28:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:28:22 INFO - 'tsvgr_opacity', 20:28:22 INFO - 'tart', 20:28:22 INFO - 'tscrollx', 20:28:22 INFO - 'cart']}, 20:28:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:22 INFO - 'talos_options': ['--disable-e10s'], 20:28:22 INFO - 'tests': ['tp5o']}, 20:28:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:22 INFO - 'tests': ['tp5o']}, 20:28:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:22 INFO - 'talos_options': ['--disable-e10s', 20:28:22 INFO - '--xperf_path', 20:28:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:28:22 INFO - 'tests': ['tp5n']}, 20:28:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:22 INFO - 'talos_options': ['--xperf_path', 20:28:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:28:22 INFO - 'tests': ['tp5n']}}, 20:28:22 INFO - 'talos.zip': {'path': '', 20:28:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:28:22 INFO - Running post-action listener: _resource_record_post_action 20:28:22 INFO - [mozharness: 2016-09-21 03:28:22.570691Z] Finished populate-webroot step (success) 20:28:22 INFO - [mozharness: 2016-09-21 03:28:22.570780Z] Running create-virtualenv step. 20:28:22 INFO - Running pre-action listener: _resource_record_pre_action 20:28:22 INFO - Running main action method: create_virtualenv 20:28:22 INFO - Creating virtualenv /builds/slave/test/build/venv 20:28:22 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 20:28:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:28:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:28:22 INFO - Using real prefix '/usr' 20:28:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:28:23 INFO - Installing distribute.............................................................................................................................................................................................done. 20:28:25 INFO - Installing pip.................done. 20:28:25 INFO - Return code: 0 20:28:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:28: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')]} 20:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28: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')]} 20:28:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:25 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 0x7f3d9c57df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121af60>, '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 0x121bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121c1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1474428486.435408-1588921463', '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 20:28:25 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 20:28:25 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 20:28:25 INFO - Using env: {'DISPLAY': ':0', 20:28:25 INFO - 'HOME': '/home/cltbld', 20:28:25 INFO - 'LANG': 'en_US.UTF-8', 20:28:25 INFO - 'LANGUAGE': 'en_US:en', 20:28:25 INFO - 'LOGNAME': 'cltbld', 20:28:25 INFO - 'MAIL': '/var/mail/cltbld', 20:28:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:25 INFO - 'MOZ_NO_REMOTE': '1', 20:28:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:25 INFO - 'NO_EM_RESTART': '1', 20:28:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:25 INFO - 'PWD': '/builds/slave/test', 20:28:25 INFO - 'SHELL': '/bin/bash', 20:28:25 INFO - 'SHLVL': '1', 20:28:25 INFO - 'TERM': 'linux', 20:28:25 INFO - 'TMOUT': '86400', 20:28:25 INFO - 'USER': 'cltbld', 20:28:25 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1474428486.435408-1588921463', 20:28:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:25 INFO - '_': '/tools/buildbot/bin/python'} 20:28:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:25 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 20:28:25 INFO - Cleaning up... 20:28:25 INFO - Return code: 0 20:28:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:28: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')]} 20:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28: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')]} 20:28:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:25 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 0x7f3d9c57df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121af60>, '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 0x121bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121c1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1474428486.435408-1588921463', '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 20:28:25 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 20:28:25 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 20:28:25 INFO - Using env: {'DISPLAY': ':0', 20:28:25 INFO - 'HOME': '/home/cltbld', 20:28:25 INFO - 'LANG': 'en_US.UTF-8', 20:28:25 INFO - 'LANGUAGE': 'en_US:en', 20:28:25 INFO - 'LOGNAME': 'cltbld', 20:28:25 INFO - 'MAIL': '/var/mail/cltbld', 20:28:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:25 INFO - 'MOZ_NO_REMOTE': '1', 20:28:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:25 INFO - 'NO_EM_RESTART': '1', 20:28:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:25 INFO - 'PWD': '/builds/slave/test', 20:28:25 INFO - 'SHELL': '/bin/bash', 20:28:25 INFO - 'SHLVL': '1', 20:28:25 INFO - 'TERM': 'linux', 20:28:25 INFO - 'TMOUT': '86400', 20:28:25 INFO - 'USER': 'cltbld', 20:28:25 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1474428486.435408-1588921463', 20:28:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:25 INFO - '_': '/tools/buildbot/bin/python'} 20:28:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:25 INFO - Downloading/unpacking psutil>=3.1.1 20:28:25 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 20:28:25 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 20:28:25 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 20:28:25 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 20:28:25 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 20:28:25 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 20:28:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:28:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:28:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:28:27 INFO - Installing collected packages: psutil 20:28:27 INFO - Running setup.py install for psutil 20:28:27 INFO - building 'psutil._psutil_linux' extension 20:28:27 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 20:28:27 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 20:28:27 INFO - building 'psutil._psutil_posix' extension 20:28:27 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 20:28:27 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 20:28:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:28:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:28:28 INFO - Successfully installed psutil 20:28:28 INFO - Cleaning up... 20:28:28 INFO - Return code: 0 20:28:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:28:28 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')]} 20:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:28 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')]} 20:28:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:28 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 0x7f3d9c57df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121af60>, '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 0x121bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121c1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1474428486.435408-1588921463', '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 20:28:28 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 20:28:28 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 20:28:28 INFO - Using env: {'DISPLAY': ':0', 20:28:28 INFO - 'HOME': '/home/cltbld', 20:28:28 INFO - 'LANG': 'en_US.UTF-8', 20:28:28 INFO - 'LANGUAGE': 'en_US:en', 20:28:28 INFO - 'LOGNAME': 'cltbld', 20:28:28 INFO - 'MAIL': '/var/mail/cltbld', 20:28:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:28 INFO - 'MOZ_NO_REMOTE': '1', 20:28:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:28 INFO - 'NO_EM_RESTART': '1', 20:28:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:28 INFO - 'PWD': '/builds/slave/test', 20:28:28 INFO - 'SHELL': '/bin/bash', 20:28:28 INFO - 'SHLVL': '1', 20:28:28 INFO - 'TERM': 'linux', 20:28:28 INFO - 'TMOUT': '86400', 20:28:28 INFO - 'USER': 'cltbld', 20:28:28 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1474428486.435408-1588921463', 20:28:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:28 INFO - '_': '/tools/buildbot/bin/python'} 20:28:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:28:28 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 20:28:28 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 20:28:28 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 20:28:28 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 20:28:28 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 20:28:28 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 20:28:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:28:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:28:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:28:30 INFO - Installing collected packages: mozsystemmonitor 20:28:30 INFO - Running setup.py install for mozsystemmonitor 20:28:30 INFO - Successfully installed mozsystemmonitor 20:28:30 INFO - Cleaning up... 20:28:30 INFO - Return code: 0 20:28:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:28: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')]} 20:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28: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')]} 20:28:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28: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', '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 0x7f3d9c57df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121af60>, '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 0x121bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121c1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1474428486.435408-1588921463', '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 20:28: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:28: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 jsonschema==2.5.1 20:28:30 INFO - Using env: {'DISPLAY': ':0', 20:28:30 INFO - 'HOME': '/home/cltbld', 20:28:30 INFO - 'LANG': 'en_US.UTF-8', 20:28:30 INFO - 'LANGUAGE': 'en_US:en', 20:28:30 INFO - 'LOGNAME': 'cltbld', 20:28:30 INFO - 'MAIL': '/var/mail/cltbld', 20:28:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:30 INFO - 'MOZ_NO_REMOTE': '1', 20:28:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:30 INFO - 'NO_EM_RESTART': '1', 20:28:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:30 INFO - 'PWD': '/builds/slave/test', 20:28:30 INFO - 'SHELL': '/bin/bash', 20:28:30 INFO - 'SHLVL': '1', 20:28:30 INFO - 'TERM': 'linux', 20:28:30 INFO - 'TMOUT': '86400', 20:28:30 INFO - 'USER': 'cltbld', 20:28:30 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1474428486.435408-1588921463', 20:28:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:30 INFO - '_': '/tools/buildbot/bin/python'} 20:28:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:30 INFO - Downloading/unpacking jsonschema==2.5.1 20:28:30 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 20:28:30 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 20:28:30 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 20:28:30 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 20:28:30 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 20:28:30 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 20:28:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:28:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:28:32 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 20:28:32 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 20:28:32 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 20:28:32 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 20:28:32 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 20:28:32 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 20:28:32 INFO - Downloading functools32-3.2.3-2.tar.gz 20:28:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:28:32 INFO - warning: no files found matching '*.txt' 20:28:32 INFO - no previously-included directories found matching 'build' 20:28:32 INFO - no previously-included directories found matching 'dist' 20:28:32 INFO - no previously-included directories found matching '.git*' 20:28:32 INFO - Installing collected packages: jsonschema, functools32 20:28:32 INFO - Running setup.py install for functools32 20:28:32 INFO - warning: no files found matching '*.txt' 20:28:32 INFO - no previously-included directories found matching 'build' 20:28:32 INFO - no previously-included directories found matching 'dist' 20:28:32 INFO - no previously-included directories found matching '.git*' 20:28:32 INFO - Successfully installed jsonschema functools32 20:28:32 INFO - Cleaning up... 20:28:33 INFO - Return code: 0 20:28:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:28: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')]} 20:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28: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')]} 20:28:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28: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', '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 0x7f3d9c57df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121af60>, '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 0x121bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121c1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1474428486.435408-1588921463', '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 20:28: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:28: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 functools32==3.2.3-2 20:28:33 INFO - Using env: {'DISPLAY': ':0', 20:28:33 INFO - 'HOME': '/home/cltbld', 20:28:33 INFO - 'LANG': 'en_US.UTF-8', 20:28:33 INFO - 'LANGUAGE': 'en_US:en', 20:28:33 INFO - 'LOGNAME': 'cltbld', 20:28:33 INFO - 'MAIL': '/var/mail/cltbld', 20:28:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:33 INFO - 'MOZ_NO_REMOTE': '1', 20:28:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:33 INFO - 'NO_EM_RESTART': '1', 20:28:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:33 INFO - 'PWD': '/builds/slave/test', 20:28:33 INFO - 'SHELL': '/bin/bash', 20:28:33 INFO - 'SHLVL': '1', 20:28:33 INFO - 'TERM': 'linux', 20:28:33 INFO - 'TMOUT': '86400', 20:28:33 INFO - 'USER': 'cltbld', 20:28:33 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1474428486.435408-1588921463', 20:28:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:33 INFO - '_': '/tools/buildbot/bin/python'} 20:28:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:28:33 INFO - Cleaning up... 20:28:33 INFO - Return code: 0 20:28:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:28: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')]} 20:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28: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')]} 20:28:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28: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', '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 0x7f3d9c57df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121af60>, '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 0x121bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121c1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1474428486.435408-1588921463', '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 20:28: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:28: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 blobuploader==1.2.4 20:28:33 INFO - Using env: {'DISPLAY': ':0', 20:28:33 INFO - 'HOME': '/home/cltbld', 20:28:33 INFO - 'LANG': 'en_US.UTF-8', 20:28:33 INFO - 'LANGUAGE': 'en_US:en', 20:28:33 INFO - 'LOGNAME': 'cltbld', 20:28:33 INFO - 'MAIL': '/var/mail/cltbld', 20:28:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:33 INFO - 'MOZ_NO_REMOTE': '1', 20:28:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:33 INFO - 'NO_EM_RESTART': '1', 20:28:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:33 INFO - 'PWD': '/builds/slave/test', 20:28:33 INFO - 'SHELL': '/bin/bash', 20:28:33 INFO - 'SHLVL': '1', 20:28:33 INFO - 'TERM': 'linux', 20:28:33 INFO - 'TMOUT': '86400', 20:28:33 INFO - 'USER': 'cltbld', 20:28:33 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1474428486.435408-1588921463', 20:28:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:33 INFO - '_': '/tools/buildbot/bin/python'} 20:28:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:33 INFO - Downloading/unpacking blobuploader==1.2.4 20:28:33 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 20:28:33 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 20:28:33 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 20:28:33 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 20:28:33 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 20:28:33 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 20:28:35 INFO - Downloading blobuploader-1.2.4.tar.gz 20:28:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:28:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:28:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:28: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 20:28: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 20:28: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 20:28: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 20:28: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 20:28: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 20:28:36 INFO - Downloading docopt-0.6.1.tar.gz 20:28:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:28:36 INFO - Installing collected packages: blobuploader, requests, docopt 20:28:36 INFO - Running setup.py install for blobuploader 20:28:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:28:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:28:36 INFO - Running setup.py install for requests 20:28:36 INFO - Running setup.py install for docopt 20:28:36 INFO - Successfully installed blobuploader requests docopt 20:28:36 INFO - Cleaning up... 20:28:36 INFO - Return code: 0 20:28:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:28: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')]} 20:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28: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')]} 20:28:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:36 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 0x7f3d9c57df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121af60>, '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 0x121bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121c1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1474428486.435408-1588921463', '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 20:28:36 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 20:28:36 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 20:28:36 INFO - Using env: {'DISPLAY': ':0', 20:28:36 INFO - 'HOME': '/home/cltbld', 20:28:36 INFO - 'LANG': 'en_US.UTF-8', 20:28:36 INFO - 'LANGUAGE': 'en_US:en', 20:28:36 INFO - 'LOGNAME': 'cltbld', 20:28:36 INFO - 'MAIL': '/var/mail/cltbld', 20:28:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:36 INFO - 'MOZ_NO_REMOTE': '1', 20:28:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:36 INFO - 'NO_EM_RESTART': '1', 20:28:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:36 INFO - 'PWD': '/builds/slave/test', 20:28:36 INFO - 'SHELL': '/bin/bash', 20:28:36 INFO - 'SHLVL': '1', 20:28:36 INFO - 'TERM': 'linux', 20:28:36 INFO - 'TMOUT': '86400', 20:28:36 INFO - 'USER': 'cltbld', 20:28:36 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1474428486.435408-1588921463', 20:28:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:36 INFO - '_': '/tools/buildbot/bin/python'} 20:28:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:28:37 INFO - Running setup.py (path:/tmp/pip-97eqRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:28:37 INFO - Running setup.py (path:/tmp/pip-10n4XP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:28:37 INFO - Running setup.py (path:/tmp/pip-w9lemb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:28:37 INFO - Running setup.py (path:/tmp/pip-WRmgH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:28:37 INFO - Running setup.py (path:/tmp/pip-xyw1Mw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:28:37 INFO - Running setup.py (path:/tmp/pip-G9bucD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:28:37 INFO - Running setup.py (path:/tmp/pip-WTl_EF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:28:37 INFO - Running setup.py (path:/tmp/pip-uLvI6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:28:37 INFO - Running setup.py (path:/tmp/pip-KJI5xP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:28:37 INFO - Running setup.py (path:/tmp/pip-Aw75Sy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:28:37 INFO - Running setup.py (path:/tmp/pip-1kBCnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:28:37 INFO - Running setup.py (path:/tmp/pip-fr5vY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:28:37 INFO - Running setup.py (path:/tmp/pip-FcGRbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:28:38 INFO - Running setup.py (path:/tmp/pip-sAJo7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:28:38 INFO - Running setup.py (path:/tmp/pip-oOzxOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:28:38 INFO - Running setup.py (path:/tmp/pip-wLfJGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:28:38 INFO - Running setup.py (path:/tmp/pip-CO2CuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:28:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:28:38 INFO - Running setup.py install for manifestparser 20:28:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:28:38 INFO - Running setup.py install for mozcrash 20:28:38 INFO - Running setup.py install for mozdebug 20:28:38 INFO - Running setup.py install for mozdevice 20:28:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:28:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:28:38 INFO - Running setup.py install for mozfile 20:28:38 INFO - Running setup.py install for mozhttpd 20:28:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:28:38 INFO - Running setup.py install for mozinfo 20:28:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:28:39 INFO - Running setup.py install for mozInstall 20:28:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:28:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:28:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:28:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:28:39 INFO - Running setup.py install for mozleak 20:28:39 INFO - Running setup.py install for mozlog 20:28:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:28:39 INFO - Running setup.py install for moznetwork 20:28:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:28:39 INFO - Running setup.py install for mozprocess 20:28:39 INFO - Running setup.py install for mozprofile 20:28:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:28:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:28:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:28:39 INFO - Running setup.py install for mozrunner 20:28:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:28:39 INFO - Running setup.py install for mozscreenshot 20:28:39 INFO - Running setup.py install for moztest 20:28:39 INFO - Running setup.py install for mozversion 20:28:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:28:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:28:40 INFO - Cleaning up... 20:28:40 INFO - Return code: 0 20:28:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:28:40 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')]} 20:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:40 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')]} 20:28:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:40 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 0x7f3d9c57df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121af60>, '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 0x121bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121c1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1474428486.435408-1588921463', '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 20:28:40 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 20:28:40 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 20:28:40 INFO - Using env: {'DISPLAY': ':0', 20:28:40 INFO - 'HOME': '/home/cltbld', 20:28:40 INFO - 'LANG': 'en_US.UTF-8', 20:28:40 INFO - 'LANGUAGE': 'en_US:en', 20:28:40 INFO - 'LOGNAME': 'cltbld', 20:28:40 INFO - 'MAIL': '/var/mail/cltbld', 20:28:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:40 INFO - 'MOZ_NO_REMOTE': '1', 20:28:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:40 INFO - 'NO_EM_RESTART': '1', 20:28:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:40 INFO - 'PWD': '/builds/slave/test', 20:28:40 INFO - 'SHELL': '/bin/bash', 20:28:40 INFO - 'SHLVL': '1', 20:28:40 INFO - 'TERM': 'linux', 20:28:40 INFO - 'TMOUT': '86400', 20:28:40 INFO - 'USER': 'cltbld', 20:28:40 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1474428486.435408-1588921463', 20:28:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:40 INFO - '_': '/tools/buildbot/bin/python'} 20:28:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:28:40 INFO - Running setup.py (path:/tmp/pip-54K1ka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:28:40 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)) 20:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:28:40 INFO - Running setup.py (path:/tmp/pip-NciNRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:28:40 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)) 20:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:28:40 INFO - Running setup.py (path:/tmp/pip-cTZ7SX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:28:40 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)) 20:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:28:40 INFO - Running setup.py (path:/tmp/pip-vxN0mW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:28:40 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)) 20:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:28:40 INFO - Running setup.py (path:/tmp/pip-NwYE3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:28:40 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)) 20:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:28:40 INFO - Running setup.py (path:/tmp/pip-ZNLuIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:28:40 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)) 20:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:28:40 INFO - Running setup.py (path:/tmp/pip-YuX37L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:28:40 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)) 20:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:28:40 INFO - Running setup.py (path:/tmp/pip-ZcOPi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:28:40 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)) 20:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:28:40 INFO - Running setup.py (path:/tmp/pip-RXL_RC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:28:40 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)) 20:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:28:40 INFO - Running setup.py (path:/tmp/pip-Ldv711-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:28:41 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)) 20:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:28:41 INFO - Running setup.py (path:/tmp/pip-TCloTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:28:41 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)) 20:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:28:41 INFO - Running setup.py (path:/tmp/pip-Uhmpeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:28:41 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)) 20:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:28:41 INFO - Running setup.py (path:/tmp/pip-EQYk4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:28:41 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)) 20:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:28:41 INFO - Running setup.py (path:/tmp/pip-RvoJ8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:28:41 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)) 20:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:28:41 INFO - Running setup.py (path:/tmp/pip-Z8ZuSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:28:41 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)) 20:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:28:41 INFO - Running setup.py (path:/tmp/pip-_HMNzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:28:41 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)) 20:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:28:41 INFO - Running setup.py (path:/tmp/pip-at11kN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:28:41 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)) 20:28:41 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)) 20:28:41 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)) 20:28:41 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)) 20:28:41 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)) 20:28:41 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)) 20:28:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:28: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 20:28: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 20:28: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 20:28: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 20:28: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 20:28: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 20:28:43 INFO - Downloading blessings-1.6.tar.gz 20:28:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:28:43 INFO - Installing collected packages: blessings 20:28:43 INFO - Running setup.py install for blessings 20:28:43 INFO - Successfully installed blessings 20:28:43 INFO - Cleaning up... 20:28:43 INFO - Return code: 0 20:28:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:28:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:28:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:28:43 INFO - Reading from file tmpfile_stdout 20:28:43 INFO - Current package versions: 20:28:43 INFO - argparse == 1.2.1 20:28:43 INFO - blessings == 1.6 20:28:43 INFO - blobuploader == 1.2.4 20:28:43 INFO - docopt == 0.6.1 20:28:43 INFO - functools32 == 3.2.3-2 20:28:43 INFO - jsonschema == 2.5.1 20:28:43 INFO - manifestparser == 1.1 20:28:43 INFO - mozInstall == 1.12 20:28:43 INFO - mozcrash == 0.17 20:28:43 INFO - mozdebug == 0.1 20:28:43 INFO - mozdevice == 0.48 20:28:43 INFO - mozfile == 1.2 20:28:43 INFO - mozhttpd == 0.7 20:28:43 INFO - mozinfo == 0.9 20:28:43 INFO - mozleak == 0.1 20:28:43 INFO - mozlog == 3.4 20:28:43 INFO - moznetwork == 0.27 20:28:43 INFO - mozprocess == 0.23 20:28:43 INFO - mozprofile == 0.28 20:28:43 INFO - mozrunner == 6.12 20:28:43 INFO - mozscreenshot == 0.1 20:28:43 INFO - mozsystemmonitor == 0.3 20:28:43 INFO - moztest == 0.7 20:28:43 INFO - mozversion == 1.4 20:28:43 INFO - psutil == 3.1.1 20:28:43 INFO - requests == 1.2.3 20:28:43 INFO - wsgiref == 0.1.2 20:28:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:43 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 0x7f3d9c57df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121af60>, '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 0x121bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121c1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1474428486.435408-1588921463', '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 20:28:43 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 20:28:43 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 20:28:43 INFO - Using env: {'DISPLAY': ':0', 20:28:43 INFO - 'HOME': '/home/cltbld', 20:28:43 INFO - 'LANG': 'en_US.UTF-8', 20:28:43 INFO - 'LANGUAGE': 'en_US:en', 20:28:43 INFO - 'LOGNAME': 'cltbld', 20:28:43 INFO - 'MAIL': '/var/mail/cltbld', 20:28:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:43 INFO - 'MOZ_NO_REMOTE': '1', 20:28:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:43 INFO - 'NO_EM_RESTART': '1', 20:28:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:43 INFO - 'PWD': '/builds/slave/test', 20:28:43 INFO - 'SHELL': '/bin/bash', 20:28:43 INFO - 'SHLVL': '1', 20:28:43 INFO - 'TERM': 'linux', 20:28:43 INFO - 'TMOUT': '86400', 20:28:43 INFO - 'USER': 'cltbld', 20:28:43 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1474428486.435408-1588921463', 20:28:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:43 INFO - '_': '/tools/buildbot/bin/python'} 20:28:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:44 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)) 20:28:44 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)) 20:28:44 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)) 20:28:44 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)) 20:28:44 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)) 20:28:44 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)) 20:28:44 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)) 20:28:44 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)) 20:28:44 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)) 20:28:44 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)) 20:28:44 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)) 20:28:44 INFO - Cleaning up... 20:28:44 INFO - Return code: 0 20:28:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:28:44 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')]} 20:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:44 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')]} 20:28:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:44 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 0x7f3d9c57df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121af60>, '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 0x121bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121c1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1474428486.435408-1588921463', '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 20:28:44 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 20:28:44 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 20:28:44 INFO - Using env: {'DISPLAY': ':0', 20:28:44 INFO - 'HOME': '/home/cltbld', 20:28:44 INFO - 'LANG': 'en_US.UTF-8', 20:28:44 INFO - 'LANGUAGE': 'en_US:en', 20:28:44 INFO - 'LOGNAME': 'cltbld', 20:28:44 INFO - 'MAIL': '/var/mail/cltbld', 20:28:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:44 INFO - 'MOZ_NO_REMOTE': '1', 20:28:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:44 INFO - 'NO_EM_RESTART': '1', 20:28:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:44 INFO - 'PWD': '/builds/slave/test', 20:28:44 INFO - 'SHELL': '/bin/bash', 20:28:44 INFO - 'SHLVL': '1', 20:28:44 INFO - 'TERM': 'linux', 20:28:44 INFO - 'TMOUT': '86400', 20:28:44 INFO - 'USER': 'cltbld', 20:28:44 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1474428486.435408-1588921463', 20:28:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:44 INFO - '_': '/tools/buildbot/bin/python'} 20:28:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:28:44 INFO - Cleaning up... 20:28:44 INFO - Return code: 0 20:28:44 INFO - Running post-action listener: _resource_record_post_action 20:28:44 INFO - Running post-action listener: _start_resource_monitoring 20:28:44 INFO - Starting resource monitoring. 20:28:44 INFO - [mozharness: 2016-09-21 03:28:44.406589Z] Finished create-virtualenv step (success) 20:28:44 INFO - [mozharness: 2016-09-21 03:28:44.407077Z] Running install step. 20:28:44 INFO - Running pre-action listener: _resource_record_pre_action 20:28:44 INFO - Running main action method: install 20:28:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:28:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:28:44 INFO - Reading from file tmpfile_stdout 20:28:44 INFO - Detecting whether we're running mozinstall >=1.0... 20:28:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:28:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:28:44 INFO - Reading from file tmpfile_stdout 20:28:44 INFO - Output received: 20:28:44 INFO - Usage: mozinstall [options] installer 20:28:44 INFO - Options: 20:28:44 INFO - -h, --help show this help message and exit 20:28:44 INFO - -d DEST, --destination=DEST 20:28:44 INFO - Directory to install application into. [default: 20:28:44 INFO - "/builds/slave/test"] 20:28:44 INFO - --app=APP Application being installed. [default: firefox] 20:28:44 INFO - mkdir: /builds/slave/test/build/application 20:28:44 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'] 20:28:44 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 20:29:00 INFO - Reading from file tmpfile_stdout 20:29:00 INFO - Output received: 20:29:00 INFO - /builds/slave/test/build/application/firefox/firefox 20:29:00 INFO - Running post-action listener: _resource_record_post_action 20:29:00 INFO - [mozharness: 2016-09-21 03:29:00.749979Z] Finished install step (success) 20:29:00 INFO - [mozharness: 2016-09-21 03:29:00.750222Z] Running run-tests step. 20:29:00 INFO - Running pre-action listener: _resource_record_pre_action 20:29:00 INFO - Running main action method: run_tests 20:29:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:29:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:29:00 INFO - Python 2.7.3 20:29:00 INFO - Return code: 0 20:29:00 INFO - grabbing minidump binary from tooltool 20:29:00 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')]} 20:29:00 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 0x121af60>, '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 0x121bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121c1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:29:00 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 20:29:00 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 20:29:00 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 20:29:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:29:00 INFO - Return code: 0 20:29:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:29:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:29:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:29:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:29:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:29:00 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/HUbAgtE-T6ilh0vonUHStg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 20:29:00 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/HUbAgtE-T6ilh0vonUHStg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 20:29:00 INFO - Using env: {'DISPLAY': ':0', 20:29:00 INFO - 'HOME': '/home/cltbld', 20:29:00 INFO - 'LANG': 'en_US.UTF-8', 20:29:00 INFO - 'LANGUAGE': 'en_US:en', 20:29:00 INFO - 'LOGNAME': 'cltbld', 20:29:00 INFO - 'MAIL': '/var/mail/cltbld', 20:29:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:29:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:29:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:29:00 INFO - 'MOZ_NO_REMOTE': '1', 20:29:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:29:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:29:00 INFO - 'NO_EM_RESTART': '1', 20:29:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:29:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:29:00 INFO - 'PWD': '/builds/slave/test', 20:29:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:29:00 INFO - 'SHELL': '/bin/bash', 20:29:00 INFO - 'SHLVL': '1', 20:29:00 INFO - 'TERM': 'linux', 20:29:00 INFO - 'TMOUT': '86400', 20:29:00 INFO - 'USER': 'cltbld', 20:29:00 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1474428486.435408-1588921463', 20:29:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:29:00 INFO - '_': '/tools/buildbot/bin/python'} 20:29:00 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/HUbAgtE-T6ilh0vonUHStg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 20:29:01 INFO - mozversion application_buildid: 20160920185816 20:29:01 INFO - mozversion application_changeset: bf78a4c31c1c85b17006883f47282bc6c40fed82 20:29:01 INFO - mozversion application_display_name: Nightly 20:29:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:29:01 INFO - mozversion application_name: Firefox 20:29:01 INFO - mozversion application_remotingname: firefox 20:29:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:29:01 INFO - mozversion application_vendor: Mozilla 20:29:01 INFO - mozversion application_version: 52.0a1 20:29:01 INFO - mozversion platform_buildid: 20160920185816 20:29:01 INFO - mozversion platform_changeset: bf78a4c31c1c85b17006883f47282bc6c40fed82 20:29:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:29:01 INFO - mozversion platform_version: 52.0a1 20:29:01 INFO - using testdate: 1474428541 20:29:01 INFO - actual date: 1474428541 20:29:01 INFO - starting webserver on 'localhost:43929' 20:29:01 INFO - SUITE-START | Running 2 tests 20:29:01 INFO - TEST-START | dromaeo_css 20:29:01 INFO - operating with platform_type : linux_ 20:29:01 INFO - Initialising browser for dromaeo_css test... 20:29:01 INFO - TEST-INFO | started process 26557 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfEniln/profile http://localhost:43929/getInfo.html) 20:29:05 INFO - PROCESS | 26557 | __metrics Screen width/height:1600/1200 20:29:05 INFO - PROCESS | 26557 | colorDepth:24 20:29:05 INFO - PROCESS | 26557 | Browser inner width/height: 1024/697 20:29:05 INFO - PROCESS | 26557 | __metrics 20:29:06 INFO - PROCESS | 26557 | 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" 20:29:06 INFO - PROCESS | 26557 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:29:06 INFO - PROCESS | 26557 | console.error: PushService: 20:29:06 INFO - PROCESS | 26557 | stateChangeProcessEnqueue: Error transitioning state 20:29:06 INFO - PROCESS | 26557 | UnknownError 20:29:07 INFO - TEST-INFO | 26557: exit 0 20:29:07 INFO - Browser initialized. 20:29:07 INFO - Running cycle 1/1 for dromaeo_css test... 20:29:07 INFO - TEST-INFO | started process 26641 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfEniln/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:29:19 INFO - PROCESS | 26641 | RSS: Main: 174723072 20:29:19 INFO - PROCESS | 26641 | 20:29:23 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.13339 seconds. 20:29:24 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 20:29:42 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 20:29:59 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01668 seconds. 20:30:07 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 20:30:11 INFO - PROCESS | 26641 | 1474428611262 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] 20:30:14 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.16674 seconds. 20:30:16 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.03338 seconds. 20:30:25 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 20:30:27 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01668 seconds. 20:30:36 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 20:30:50 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.35007 seconds. 20:30:55 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.03339 seconds. 20:31:02 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 20:31:04 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.05005 seconds. 20:31:06 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.05001 seconds. 20:31:12 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.03338 seconds. 20:31:20 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 20:31:22 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 20:31:23 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 2.01678 seconds. 20:31:39 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 20:31:45 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.16673 seconds. 20:31:49 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 20:31:59 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 20:32:04 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01674 seconds. 20:32:06 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 20:32:12 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.05002 seconds. 20:32:16 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01677 seconds. 20:32:18 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.06672 seconds. 20:32:21 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 20:32:23 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.03338 seconds. 20:32:24 INFO - PROCESS | 26641 | Cycle 1(1): loaded http://localhost:43929/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43929/tests/dromaeo/cssquery-ext.html) 20:32:25 INFO - PROCESS | 26641 | RSS: Main: 292331520 20:32:25 INFO - PROCESS | 26641 | 20:32:29 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01681 seconds. 20:32:36 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.05003 seconds. 20:32:39 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 20:32:42 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 20:32:44 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 20:32:46 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 20:32:48 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 20:33:00 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 20:33:10 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 20:33:17 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 20:33:23 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.05005 seconds. 20:33:26 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 20:33:30 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 20:33:32 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 20:33:42 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00009 seconds. 20:33:50 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 20:34:07 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 20:34:13 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 20:34:19 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 20:34:29 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 20:34:32 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 20:34:34 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 20:34:35 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 20:34:36 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 2.01674 seconds. 20:34:56 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 20:34:59 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 20:35:05 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 20:35:17 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00035 seconds. 20:35:21 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 20:35:23 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 20:35:25 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 20:35:28 INFO - PROCESS | 26641 | Cycle 1(1): loaded http://localhost:43929/tests/dromaeo/cssquery-ext.html (next: http://localhost:43929/tests/dromaeo/cssquery-jquery.html) 20:35:28 INFO - PROCESS | 26641 | RSS: Main: 273211392 20:35:28 INFO - PROCESS | 26641 | 20:35:34 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.05013 seconds. 20:35:56 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 20:35:59 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 20:36:07 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 20:36:17 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1 seconds. 20:36:21 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 20:36:23 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 20:36:33 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 20:36:37 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 20:36:47 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 20:36:49 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 20:37:02 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 20:37:04 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01674 seconds. 20:37:16 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 20:37:20 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 20:37:24 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 20:37:48 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 20:38:00 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 20:38:02 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 20:38:10 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00008 seconds. 20:38:14 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 20:38:16 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 20:38:18 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 20:38:20 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 20:38:23 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 20:38:26 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 20:38:30 INFO - PROCESS | 26641 | Cycle 1(1): loaded http://localhost:43929/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43929/tests/dromaeo/cssquery-mootools.html) 20:38:31 INFO - PROCESS | 26641 | RSS: Main: 220233728 20:38:31 INFO - PROCESS | 26641 | 20:38:34 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.03343 seconds. 20:38:46 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 20:38:54 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 20:38:56 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 20:39:03 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 20:39:17 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.03339 seconds. 20:39:26 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 20:39:30 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 20:39:38 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 20:39:40 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 20:40:06 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 20:40:27 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 20:40:39 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 20:40:47 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 20:40:49 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 20:40:51 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 20:40:57 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 20:41:15 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 20:41:31 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 20:41:33 INFO - PROCESS | 26641 | Cycle 1(1): loaded http://localhost:43929/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43929/tests/dromaeo/cssquery-prototype.html) 20:41:34 INFO - PROCESS | 26641 | RSS: Main: 221200384 20:41:34 INFO - PROCESS | 26641 | 20:41:51 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 20:42:10 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 20:42:11 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 20:42:13 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 20:42:29 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 20:42:31 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 20:42:46 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 20:42:52 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 20:42:54 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 20:43:04 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 20:43:06 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 20:43:17 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 20:43:18 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 20:43:19 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 2.0001 seconds. 20:43:20 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 20:43:22 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 20:43:25 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01674 seconds. 20:43:28 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00009 seconds. 20:43:31 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 20:43:36 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 20:43:48 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 20:43:56 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 20:44:01 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 20:44:07 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 20:44:09 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1 seconds. 20:44:16 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00008 seconds. 20:44:25 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 20:44:28 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 20:44:35 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 20:44:37 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 20:44:37 INFO - PROCESS | 26641 | Cycle 1(1): loaded http://localhost:43929/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43929/tests/dromaeo/cssquery-yui.html) 20:44:38 INFO - PROCESS | 26641 | RSS: Main: 220024832 20:44:38 INFO - PROCESS | 26641 | 20:44:41 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.03331 seconds. 20:44:45 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 20:44:58 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01674 seconds. 20:45:10 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 20:45:19 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 20:45:23 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 20:45:37 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 20:45:57 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 20:46:01 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 20:46:03 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 20:46:21 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 20:46:23 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 20:46:25 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 20:46:27 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 20:46:32 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 20:46:34 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00009 seconds. 20:46:36 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 20:46:38 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 20:46:40 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 20:46:42 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 20:46:44 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 20:46:52 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 20:47:06 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 20:47:10 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01668 seconds. 20:47:20 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 20:47:26 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 20:47:32 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01676 seconds. 20:47:34 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01668 seconds. 20:47:36 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.01668 seconds. 20:47:38 INFO - PROCESS | 26641 | [GFX1-]: Refresh driver waiting for the compositor for 1.0001 seconds. 20:47:40 INFO - PROCESS | 26641 | Cycle 1(1): loaded http://localhost:43929/tests/dromaeo/cssquery-yui.html (next: http://localhost:43929/tests/dromaeo/cssquery-dojo.html) 20:47:41 INFO - PROCESS | 26641 | RSS: Main: 302497792 20:47:41 INFO - PROCESS | 26641 | 20:47:41 INFO - PROCESS | 26641 | __start_tp_report 20:47:41 INFO - PROCESS | 26641 | _x_x_mozilla_page_load 20:47:41 INFO - PROCESS | 26641 | _x_x_mozilla_page_load_details 20:47:41 INFO - PROCESS | 26641 | |i|pagename|runs| 20:47:41 INFO - PROCESS | 26641 | |0;dojo.html;2556.7954563634903;2589.1585234798695;2619.1356852238764;2628.5662865627173;2641.247244535308;4535.705179163352;4622.1217968586025;4731.313959475874;4745.050989802036;4746.857594272173;4646.744429056401;4670.719756814602;4681.344611754357;4688.601468875149;4699.271612900006;4262.360645903108;4272.401863739079;4306.978465107686;4327.870163895088;4402.911941761179;4350.912981740364;4402.3836662867225;4414.359917811916;4431.512533621299;4485.842995495158;4267;4318.676099292566;4333.133373325331;4357.41174941382;4357.934630980538;4258.467691538558;4280.464941882265;4360.149770794696;4375.14684636496;4379.627731642814;4287.571242875719;4298.613124818781;4342.804573794156;4348.782560871975;4364.432623758923;4621.399218101626;4656.790444430008;4685.273782563708;4697.107549565571;4758.809647614091;4951.207806750903;4982.60139188864;5021.648484606079;5041.243813427978;5048.5203905628905;5029.1953287473825;5030.949690503085;5032.47159048302;5080.669756465818;5087.49125087492;4676.69601475903;4678.391809064799;4683.859484215479;4687.71873687573;4746.288056791509;5035.924461133086;5102.464241254689;5120.359955005624;5122.667026643257;5184.351956005499;4885.975570122127;4917.385326834145;4947.233178857283;4968.279599458058;4986.401631804207;5013.373328333958;5014.623903207201;5016.247562865527;5026.79892804291;5092.821751238763;5051.166557518042;5064.215046667772;5065.670731402521;5069.264956581275;5090.694558326512;4856.757162141878;4898.755062246873;5056.595472362203;5061.392632884077;5069.44236134025;4292.527821939584;4313.568643135724;4317.11499142675;4324.286492728727;4328.04782947751;3724.0689827543115;3752.2870654575545;3756.73702840804;3773.4905787718308;3777.6411240932066;4298.63461605767;4343.261645520269;4384.232759267115;4389.670774691911;4431.711938723973;5034.597232221414;5077.923831142536;5092.592592592584;5098.311727916758;5168.9224661630105;4366.323219900921;4397.934030989538;4400.9559904401185;4401.559844015637;4450.910981780346;4585.876460267189;4587.472440669299;4594.839180628662;4597.977010114928;4647.837325693585;4566.3150527420485;4604.5165257648805;4710.717356958594;4741.596964257938;4752.691075080109;5049;5055.772490237875;5056.292119103255;5058.9494105058475;5103.10695628271;4743.691660042086;4745.691530050535;4745.810167593258;4794.808207671654;4802.039592081667;4872.171730805842;4884.096442158212;4913.65604407688;4945.406551213733;4978.775955082103;5049.065922804293;5049.747512624427;5050.949490505048;5096.464871188472;5108.259302401057;4895;4929.841487250422;4930.063287975417;4930.841252305633;4996.6002719783055;4740.288956656391;4828.227483602606;4875.219964805614;4877.707337559757;4946.653734238569;4769.809207631656;4863.051704917507;4866.48901865299;4922.483139270468;4931.334269873521;4901.852944411673;4966.701997880139;4968.205087186033;4985.127602669446;5046.545810877039;4682.297655351725;4783.593394561502;4817.373741413734;4850.320955066223;4867.610591152628 20:47:41 INFO - PROCESS | 26641 | |1;ext.html;563.6956043736383;571.6798592788039;575.5280669850722;581.2153592649926;581.8138195777353;27850.721492785065;28820.56769148462;37968.620313796855;39043.60956390442;39161.41257881134;39422.21155576887;39831.800840995755;39860.80069599655;39873.80063099688;39881.800590997074;7533.698652053911;7687.500312479699;7692.499987500794;7696.461247712662;7697.538147711127;7616.124145723257;7715.189905059972;7724.729634462795;7724.884126738103;7735.8066048348965;7736.497127686711;7781.144074151839;7783.066032076159;7785.1436342002335;7790.727324543642;7700.614969251515;7717.884231736529;7737.651805668758;7747.922520774805;7755.418343624195;7518.548887066739;7570.129435114977;7575;7581.54510729358;7585.772426827204;36831.263374732356;37201;37204;37272.44091338632;37280.44079338812;2764.3227409284855;2777.5833624956217;3008.849557522137;3046.3907218556155;3072.7080927311868;27671.30821729453;27680.446391072066;29002.854985725146;29065.854670726512;31171.68828311733;3453.913652158716;3504.842282097312;3524.22467057247;3532.717382609385;3601.927961440783;246465;248795;249107.9999999982;249664;251807;55744.72127639417;56427.71786141043;56455;56562.43437565654;56569;32675.183120421705;33642.49536256958;33730.831345843115;35485.29029419397;35497.82251088728;15277.541673749805;15528.689426211413;15557.29992150356;15570.688586228212;15577.688446231012;11283.266587671775;11432.657020289405;11448.542058317575;11448.599299024494;11451.198416110792;18637.81362186388;18761;18787.15457804402;18830.90584547096;18894;7181.605011724405;7188.460865435113;7191.496595238388;7212.531185472927;7235;752.6537792615459;892.7187935800332;934.7663084228943;940.4545363689044;944.976375590602;26537;26775.330616734347;27664.723352766618;27815.443691126467;27828.165155045383;768.6041688530412;866.7139843851514;898.1422741282059;955.1069749783974;1001.0040010189762;12862.871371286354;15728.449504267295;16380.180990950405;16384.83615163833;16824.978231123274;372282;377320;377913;378437;378723;48886;48980.51019489759;49193.26210106851;49254;49360;1056.6196169379018;1078.9784204316027;1167.1888037813637;1175.8471398718111;1182.2079206931376;26334;28859.85570072136;29910.25224369408;31080.378392431572;31786.682133178372;45337;45852;45933.31100033569;45960.54039459563;45985.77007115077;316352;318107;318462;320778;321111;25198.370040749127;25358.492830142925;25746.227613171635;25940.092096776523;25958.159414132424;39969.200615986934;40772.38841417322;41306.380404293355;41413.378799317434;41962;34062;34524.48213276853;34612.65387346094;35044.82477587596;35424.46863297001;34795.478067828495;35127;35609.1097722559;35798.8210058948;35883.82058089693;34128.31743365168;34583.13542161466;35041.64958350384;35301.1174720634;35609;30789.846050769604;33287;33341.83329083339;33351.49972750362;33510.66489335075;24387.26838194857;24850.50298994046;25139.54848752278;25499.617505737056;25772.8711356442 20:47:41 INFO - PROCESS | 26641 | |2;jquery.html;344.2254926415565;360.7258483552501;365.74946161879114;369.16200225488143;388.2952441319006;12343.876561234385;15776.447824326136;15779.999999999985;16533.834661653378;17757.378491752792;16024.519264422057;16500.587485312873;17287.567810804736;17470.912645436754;17477.47567572972;4968.205087186042;5059.595232381401;5096.261042148886;5096.974515127419;5117.692938423688;3710.239400922804;4958.082754690376;5130.486951304858;5134.435212126663;5136.820211292606;3867.1105645701505;5610.354809196933;5868.354481007086;5896.498797602209;5994.46049855513;5207.531322181022;5480.205370221335;5976.88046239075;5977.7608895644125;5978.940210597903;5415.268938693265;5420.945790542123;5422.593305502103;5425.701586412746;5426.8371948841595;11902.464389102424;12002.759944801055;12308.26150430977;12600.306983115925;12672.556460523838;1959.9314024009234;1982.7422435083347;2132.986831255157;2207.878566678832;2286.9480039181994;9231.769205769842;9467.289953253465;9586.520673966343;11989.93196600789;12490.875091249152;1678.7230107032326;1746.1356628468861;1746.903920284384;1759.7888253409544;1838.1366126194262;63604;69437.65281173562;69824.30175698228;70174.29825701729;71235.28764712339;9492.677562853085;9866;10141.695749127539;10151.94924025375;10363.170946324275;14015.789763153562;14031.579052628438;14032.158070515801;14035.298235088409;14044.71910561783;7308.488405811542;7506.099268087864;7627.809304767426;7707.961460192775;7741.7677469676;7087.82280442993;7217.684526039715;7311.341979221896;7420.777376678709;7428.962855185798;4125.092479654471;4254.808533615995;4258.552851950562;4393.231184542692;4420.270655341833;1729.5848996240811;1736.8089510153873;1754.2982806877096;1771.5305444057335;1796.9011704356385;790.8457850719054;807.4590024683476;823.7940514871282;840.1514470384956;868.487592320534;15860.52418427449;16135.19324033817;16745.07902065374;17241.655166896842;17658.205380757896;769.4882902869641;805.6777289084413;805.8549461097059;818.300353198019;843.6920524008692;9269;9406.16579766939;9785.36395134314;9802.313838031268;9818.013156516683;376184;411072;413166;415360;416303;78404.8472486754;80323.59838200889;80960;81484.59257703673;83226.58386708148;850.9531975741394;870.2472361407464;871.1636828644446;874.6676263020139;880.5245167609419;14938.477153299582;15049.75435194382;15297.46458873934;15374.846251537341;15996.680066398374;36323.27353452969;36478.45282320714;37035.81482092572;37204.44193337156;37213.62786372102;49806;50120.24819627781;50371.24443133282;50400;50427.74786126046;7554.206808285051;7707.383409327353;7893.131755506774;8082.393820463606;8087.069986951341;11096.778064438504;11403.258788178742;11592.710182245512;11791.528338866348;12219.26684398939;9696.9030309696;9868.85196722064;10363.844542332023;10493.580256789643;10893.509792059218;10120.493975301353;10311.278210525492;10435.269531132748;10609.840852387375;10785.946070269598;10258.43578603184;10408.375497470177;10476.68569942903;10549.419781912069;10878.184136189975;6789.355011273921;7109.360157585842;7152.9985801988805;7169.068021157216;8066.516009039242;8735.56322183901;10194.286399951932;10316.948415257875;10704.571817127227;10780.083692885879 20:47:41 INFO - PROCESS | 26641 | |3;mootools.html;1243.9378031098443;1368.7194125204335;1400.2788563889596;1452.4262916148123;1676.1870492810992;6872.415844653205;7830.4518683692095;8102.756917292476;8186.713465028725;8224;7963.840723185533;8088.95955520223;8105.959470202641;8106.716264930728;8111.75664730059;2172.7066845975787;2201.691763153152;2207.260567709819;2207.3598656389627;2207.75714671386;2104.1057550541036;2167.2522979572022;2183.4541364658835;2185.694002839604;2194.6049711052005;2134.3063504361066;2162.243214874797;2169.40341406113;2169.5877783221217;2195.3413975807193;2069.4102180878454;2085.614161380142;2085.9165633374646;2087.4155236533793;2088.1960445228547;2069.6688529835305;2122.373899699592;2125.777677835251;2130.8614940028847;2139.240569597786;7829.1779363166615;7951.880721789178;8034.116247212802;8038.758837234892;8113;4246.7027308088445;4395.648348132142;4406.405135306724;4407.625351845097;4408.228560002019;2595.50685369781;2706.2963629456285;2747.4230411613585;2755.586662000696;2761.295869553271;899.8065415935605;905.1129892705186;915.9862602060974;918.196577994255;927.4898805656929;10405.21960852939;10546.683599492027;10609.15126789855;10622.521986510626;10657.946710266398;3733;3917.7061720371084;4024.5774193709826;4052.8176232069627;4077.857274995361;8418.074011858691;8418.452800567944;8430.24127828486;8430.915690843136;8436.662533498715;4411.02957349389;4413.3821265022925;4414.690971632019;4423.823047078081;4434.800433980478;3657.122290650225;3762.3227818992846;3943.7830919299713;4110.917781644351;4120.938185927213;3396.3207358528393;3406.67636574525;3495.545579074704;3553.2715793262837;3556.253186830743;1032.7934413117407;1041.6198087697935;1045.7072019834307;1051.9947400263102;1055.150603763962;723.2731105239201;760.3992845651873;778.9143194248628;781.1368437876065;781.2578050851714;4880.6095512358925;4941.209406494943;4958.826441074617;5025.572826309804;5088.796448142033;390.958949310324;401.76898283486526;403.41303403547766;407.21407683171765;411.06072624053894;3255.7558183135884;3379.0369744622662;3477.217626034122;3576.5529308836394;3627.5828279748166;8913.598888050054;9549.427034377959;9570;9594.376365536218;9616.51917404127;9479.620815167316;9482.099200575934;9484.478353690476;9517.904820951702;9535.856962145574;7214.567125972459;7424.480286379901;7436.553806771611;7462.216467270967;7470.925290747023;5116;5181.35233095863;5284.471552844839;5325.414204437431;5511.559075273888;8903.688370906988;8930.508822014852;8951.955240223757;9020.864687029569;9044.824172857487;8810;9039.774005649911;9062.954685226532;9130.269578433577;9132.132447417485;6609.239937407259;6773.593584384756;7459.36595389398;7552.471327007057;7682.6926922924695;7191.964040179766;7317.341439270278;7367.889481657887;7571.697132114654;7582.54504729718;6759.5606285591275;6777.254502004874;6822.692978815866;6870.690818913061;7085.645717713991;6686.06395104676;6714.2278637955305;6853.143357080365;6858;7012.193597736122;6006.069059295816;6103.84740381494;6104.32852386246;6105;6106.847328816815;4384.188925048876;4394.143142087262;4450.376947227326;4454.242778727689;4530.0486897750525;4408.6693497987135;4438.955610443854;4455.487618923865;4485.304777759453;4522.615577675934 20:47:41 INFO - PROCESS | 26641 | |4;prototype.html;283.1533714194558;284.7223956642273;290.32644265304504;291.51317300108815;292.0915951391174;4833.453294945614;4853.199222128349;4860.4896485869;4861.173600487917;4896.2410826321975;4797.96843678609;4808.489802444218;4819.32529445877;4832.903341933159;4856.781444834982;3522.1546828761043;3631.654992775682;3679.22736225393;3772.2832661794173;3782.565005024416;3784.8615532224344;3787.431885217212;3788;3792.374258247386;3797.563280222782;3716.591174970751;3719.163188282642;3726.273376691546;3731.160488890005;3787.3182827091114;3519.8592056317843;3622.5290712207507;3640.5631324240994;3725.9068523286865;3751.4560388743616;3303.4219011672863;3310.1062713067577;3313.2545177335146;3319.8008119512906;3328.2012317043977;4605.562471565229;4652.883677908046;4663.2305669564485;4670.7664616769025;4691;4173.895652608679;4269.594388533084;4288.785560721952;4289.506706728735;4318.4170137031415;4968.8757781055765;5005.224190250517;5014.874628134289;5017.673851199696;5031.52200540948;3570.589382221026;3600.135967367839;3610.5125808016105;3616.594964348705;3617.981910090459;5143.151380022292;5182.948170518284;5262.578993680497;5264.947350526484;5296.702307934542;3607.7113830893463;3640.6177351378255;3649.94525082124;3658.378075727133;3668.3947148720695;3670.871519496805;3688.39141541648;3702.2595480903387;3716.3682174030478;3722.590515043343;4236.830526778956;4269.146170765797;4275.636570891447;4282.314829627245;4282.571742825692;4961.982793527318;5005.974970125126;5062.164742817467;5085.9147749422555;5135.717535535581;1279.0918447901909;1301.4208677138583;1309.5482058689736;1315.9210447372998;1316.5918565244613;784.7645706288091;810.3557671651051;832.5129799067493;841.7096101844854;844.5692696724592;4267.8079486423185;4317.460317460317;4410.360497727812;4462.843800466968;4469.21788686985;5177.3269474968765;5179.766910489037;5182.274481572583;5190.480951904779;5199.142141546602;4464.598186163261;4468.865934021985;4470.195364834361;4485.484169320504;4498.280275155959;2601.596752503365;2745.1490038088255;2757.1389312214174;2762.6822915364587;2764.3365592258115;4904.583110435653;4914.680545764585;4948.38145231846;4950.415866922623;4954.9752251238515;5007.774650140753;5234.293370395024;5366.275552800322;5369.6509726867625;5369.919451208235;4819.662623616313;4844.636652251095;4856.41722993236;4872.658913875995;4915.778789954461;5191.521680474167;5196.402413722471;5206.271122042841;5247.192751877879;5271.499207575274;4976.5023497649945;5133.512316329943;5136.512031357015;5138.588912887035;5174.6119041072825;4852;4853.733044682435;4886.144924638245;4927.630427717864;4928.162212423968;3688.3360995021153;3691.2617476505343;3696.445533170046;3698.852045918133;3723.9813800931906;4933.358663373739;5149.510796474329;5153.943441594539;5205.297284866646;5213.869653258699;4964;4994.400671919393;5027.824026159067;5055.862430953006;5060.1903695408555;5053.823116191063;5064.696118232918;5069.467705890828;5077.365329333833;5085.38102877026;4699.671023028492;4936.234883593049;4940.8764780880765;4973.776180071833;5013.793930670493;4892.48628893961;4897.702108941062;5008.899822003613;5079.593632509464;5119.411267704113;4996.325496057985;4997.775100120431;5008.549230569266;5012.7718708916545;5016.799328026838 20:47:41 INFO - PROCESS | 26641 | |5;yui.html;559.1054313099041;584.2404873664235;591.1221835574172;608.2700759089092;613.129356314034;12191;12928.771766682174;13286.13640113392;13308.534201302957;13309.933450332746;12147.696307592314;12502.81245781314;12561.371931403439;12637.684057898558;12646.557370492035;605.7032054293387;734.794257607868;761.075293518375;764.6788348893479;765.4985984180371;617.9104029915682;735.1692587376284;756.8486302739474;761.2121454294806;765.2500549461531;812.9227723366271;813.5484805932705;816.2408959667507;816.2408959667507;816.5223344343566;631.3307893632764;808.59974312715;808.8746244332109;809.2069771623812;809.550699361854;477.46762359968733;558.9776408943637;577.656294504769;577.8757567123089;580.8373655376502;12142.939285303517;12153.210041347284;12161.5135394585;12170.087243456775;12182.634520964386;11189.888101118966;11705.473253703518;11731.413429328584;11998.120451091763;12227.816582751266;10485.475726213659;10669.466526673712;10728.195385346053;10783.730406739816;10793.460326983697;3759.7744135351695;3803.744764227798;3834.2523207974455;3854.5759966403675;3888.2612303662213;61578.69210653918;61847.38152618461;61868.69065654688;62025.68987155081;62156.37843621551;9219.262459003263;9246.352755307063;9497.720547068653;9566.521673916277;9982.600695972225;17262.913685431493;17275.481735547954;17302;17415.47753567395;17443.21505532254;6320.968395158086;6384.744610215632;6438.54930154894;6512.120863683437;6769.323067693192;3390.9491357629654;3393.5588373511778;3460.7058400035776;3488.389531831919;3546.556680414948;2728.5088684037064;2801.551751719715;2803.1730639461407;2810.634617499753;2813.5779633054794;480.4090968109245;491.65584091135634;495.15823100728903;527.5621234375536;559.2589818490517;443.4169067675996;491.54286513542746;492.59361027152744;504.05992823384855;512.4849526226119;7228.602426866572;7498.4376171787335;7548.433867459853;7652.273034061755;7808.141104478503;419.2662840029948;472.1713392995271;485.70614778059473;489.80652642206843;497.7685376300038;3503.6146023937345;3521.3661540922367;3532.8056956867104;3675.2833197526224;3697.796621185807;58151;94247.52876235712;98038;111171;111261;84984.00319935914;86872.56563717268;87719;88022;89310.55344723235;82630.58684706538;83242;84024;84248.57875710582;84920.72618910721;6764.526483146133;6833.111695479556;6863.4726780992105;7057.50597458173;7081.8937715935335;48847.755761220964;49331.50668493269;49743.50256497534;50678.2398264019;51481;60151.69924150351;68959.65520172367;69585;69739.74944760479;73109;8436.704715334934;8665.133486651537;8798;8928.285737141143;8977.730668079968;9952.751181220527;9952.850707239542;9980.700578982642;10047;10274.33216840903;9170.633174672937;9429;9510.619575216913;9612.51937403113;9990.100890919852;9423.38747981379;9559.665411710557;9590.328676992543;9737;9917.553710082919;9127.132922372364;9264.814703705753;9393.81212375735;9518.381305215138;9806.362586431858;7981.414097288094;8219.219174178443;8297.10558014795;8315.750527484186;8354.45696029756;8064.758057258292;8079.555624440713;8245.505269683837;8480.74557763268;8527.232549070613 20:47:41 INFO - PROCESS | 26641 | __end_tp_report 20:47:41 INFO - PROCESS | 26641 | __start_cc_report 20:47:41 INFO - PROCESS | 26641 | _x_x_mozilla_cycle_collect,1045 20:47:41 INFO - PROCESS | 26641 | __end_cc_report 20:47:41 INFO - PROCESS | 26641 | __startTimestamp1474429661218__endTimestamp 20:47:41 INFO - PROCESS | 26641 | 20:47:41 INFO - PROCESS | 26641 | ------- Summary: start ------- 20:47:41 INFO - PROCESS | 26641 | Number of tests: 6 20:47:41 INFO - PROCESS | 26641 | 20:47:41 INFO - PROCESS | 26641 | [#0] dojo.html Cycles:165 Average:4658.62 Median:4746.86 stddev:485.40 (10.2%) stddev-sans-first:458.03 20:47:41 INFO - PROCESS | 26641 | Values: 2556.8 2589.2 2619.1 2628.6 2641.2 4535.7 4622.1 4731.3 4745.1 4746.9 4646.7 4670.7 4681.3 4688.6 4699.3 4262.4 4272.4 4307.0 4327.9 4402.9 4350.9 4402.4 4414.4 4431.5 4485.8 4267.0 4318.7 4333.1 4357.4 4357.9 4258.5 4280.5 4360.1 4375.1 4379.6 4287.6 4298.6 4342.8 4348.8 4364.4 4621.4 4656.8 4685.3 4697.1 4758.8 4951.2 4982.6 5021.6 5041.2 5048.5 5029.2 5030.9 5032.5 5080.7 5087.5 4676.7 4678.4 4683.9 4687.7 4746.3 5035.9 5102.5 5120.4 5122.7 5184.4 4886.0 4917.4 4947.2 4968.3 4986.4 5013.4 5014.6 5016.2 5026.8 5092.8 5051.2 5064.2 5065.7 5069.3 5090.7 4856.8 4898.8 5056.6 5061.4 5069.4 4292.5 4313.6 4317.1 4324.3 4328.0 3724.1 3752.3 3756.7 3773.5 3777.6 4298.6 4343.3 4384.2 4389.7 4431.7 5034.6 5077.9 5092.6 5098.3 5168.9 4366.3 4397.9 4401.0 4401.6 4450.9 4585.9 4587.5 4594.8 4598.0 4647.8 4566.3 4604.5 4710.7 4741.6 4752.7 5049.0 5055.8 5056.3 5058.9 5103.1 4743.7 4745.7 4745.8 4794.8 4802.0 4872.2 4884.1 4913.7 4945.4 4978.8 5049.1 5049.7 5050.9 5096.5 5108.3 4895.0 4929.8 4930.1 4930.8 4996.6 4740.3 4828.2 4875.2 4877.7 4946.7 4769.8 4863.1 4866.5 4922.5 4931.3 4901.9 4966.7 4968.2 4985.1 5046.5 4682.3 4783.6 4817.4 4850.3 4867.6 20:47:41 INFO - PROCESS | 26641 | 20:47:41 INFO - PROCESS | 26641 | [#1] ext.html Cycles:180 Average:46518.29 Median:35454.88 stddev:83999.64 (236.9%) stddev-sans-first:84164.41 20:47:41 INFO - PROCESS | 26641 | Values: 563.7 571.7 575.5 581.2 581.8 27850.7 28820.6 37968.6 39043.6 39161.4 39422.2 39831.8 39860.8 39873.8 39881.8 7533.7 7687.5 7692.5 7696.5 7697.5 7616.1 7715.2 7724.7 7724.9 7735.8 7736.5 7781.1 7783.1 7785.1 7790.7 7700.6 7717.9 7737.7 7747.9 7755.4 7518.5 7570.1 7575.0 7581.5 7585.8 36831.3 37201.0 37204.0 37272.4 37280.4 2764.3 2777.6 3008.8 3046.4 3072.7 27671.3 27680.4 29002.9 29065.9 31171.7 3453.9 3504.8 3524.2 3532.7 3601.9 246465.0 248795.0 249108.0 249664.0 251807.0 55744.7 56427.7 56455.0 56562.4 56569.0 32675.2 33642.5 33730.8 35485.3 35497.8 15277.5 15528.7 15557.3 15570.7 15577.7 11283.3 11432.7 11448.5 11448.6 11451.2 18637.8 18761.0 18787.2 18830.9 18894.0 7181.6 7188.5 7191.5 7212.5 7235.0 752.7 892.7 934.8 940.5 945.0 26537.0 26775.3 27664.7 27815.4 27828.2 768.6 866.7 898.1 955.1 1001.0 12862.9 15728.4 16380.2 16384.8 16825.0 372282.0 377320.0 377913.0 378437.0 378723.0 48886.0 48980.5 49193.3 49254.0 49360.0 1056.6 1079.0 1167.2 1175.8 1182.2 26334.0 28859.9 29910.3 31080.4 31786.7 45337.0 45852.0 45933.3 45960.5 45985.8 316352.0 318107.0 318462.0 320778.0 321111.0 25198.4 25358.5 25746.2 25940.1 25958.2 39969.2 40772.4 41306.4 41413.4 41962.0 34062.0 34524.5 34612.7 35044.8 35424.5 34795.5 35127.0 35609.1 35798.8 35883.8 34128.3 34583.1 35041.6 35301.1 35609.0 30789.8 33287.0 33341.8 33351.5 33510.7 24387.3 24850.5 25139.5 25499.6 25772.9 20:47:41 INFO - PROCESS | 26641 | 20:47:41 INFO - PROCESS | 26641 | [#2] jquery.html Cycles:180 Average:24628.69 Median:4256.68 stddev:67146.71 (1577.4%) stddev-sans-first:67310.32 20:47:41 INFO - PROCESS | 26641 | Values: 344.2 360.7 365.7 369.2 388.3 12343.9 15776.4 15780.0 16533.8 17757.4 16024.5 16500.6 17287.6 17470.9 17477.5 4968.2 5059.6 5096.3 5097.0 5117.7 3710.2 4958.1 5130.5 5134.4 5136.8 3867.1 5610.4 5868.4 5896.5 5994.5 5207.5 5480.2 5976.9 5977.8 5978.9 5415.3 5420.9 5422.6 5425.7 5426.8 11902.5 12002.8 12308.3 12600.3 12672.6 1959.9 1982.7 2133.0 2207.9 2286.9 9231.8 9467.3 9586.5 11989.9 12490.9 1678.7 1746.1 1746.9 1759.8 1838.1 63604.0 69437.7 69824.3 70174.3 71235.3 9492.7 9866.0 10141.7 10151.9 10363.2 14015.8 14031.6 14032.2 14035.3 14044.7 7308.5 7506.1 7627.8 7708.0 7741.8 7087.8 7217.7 7311.3 7420.8 7429.0 4125.1 4254.8 4258.6 4393.2 4420.3 1729.6 1736.8 1754.3 1771.5 1796.9 790.8 807.5 823.8 840.2 868.5 15860.5 16135.2 16745.1 17241.7 17658.2 769.5 805.7 805.9 818.3 843.7 9269.0 9406.2 9785.4 9802.3 9818.0 376184.0 411072.0 413166.0 415360.0 416303.0 78404.8 80323.6 80960.0 81484.6 83226.6 851.0 870.2 871.2 874.7 880.5 14938.5 15049.8 15297.5 15374.8 15996.7 36323.3 36478.5 37035.8 37204.4 37213.6 49806.0 50120.2 50371.2 50400.0 50427.7 7554.2 7707.4 7893.1 8082.4 8087.1 11096.8 11403.3 11592.7 11791.5 12219.3 9696.9 9868.9 10363.8 10493.6 10893.5 10120.5 10311.3 10435.3 10609.8 10785.9 10258.4 10408.4 10476.7 10549.4 10878.2 6789.4 7109.4 7153.0 7169.1 8066.5 8735.6 10194.3 10316.9 10704.6 10780.1 20:47:41 INFO - PROCESS | 26641 | 20:47:41 INFO - PROCESS | 26641 | [#3] mootools.html Cycles:180 Average:5067.91 Median:4910.91 stddev:2917.88 (59.4%) stddev-sans-first:2911.92 20:47:41 INFO - PROCESS | 26641 | Values: 1243.9 1368.7 1400.3 1452.4 1676.2 6872.4 7830.5 8102.8 8186.7 8224.0 7963.8 8089.0 8106.0 8106.7 8111.8 2172.7 2201.7 2207.3 2207.4 2207.8 2104.1 2167.3 2183.5 2185.7 2194.6 2134.3 2162.2 2169.4 2169.6 2195.3 2069.4 2085.6 2085.9 2087.4 2088.2 2069.7 2122.4 2125.8 2130.9 2139.2 7829.2 7951.9 8034.1 8038.8 8113.0 4246.7 4395.6 4406.4 4407.6 4408.2 2595.5 2706.3 2747.4 2755.6 2761.3 899.8 905.1 916.0 918.2 927.5 10405.2 10546.7 10609.2 10622.5 10657.9 3733.0 3917.7 4024.6 4052.8 4077.9 8418.1 8418.5 8430.2 8430.9 8436.7 4411.0 4413.4 4414.7 4423.8 4434.8 3657.1 3762.3 3943.8 4110.9 4120.9 3396.3 3406.7 3495.5 3553.3 3556.3 1032.8 1041.6 1045.7 1052.0 1055.2 723.3 760.4 778.9 781.1 781.3 4880.6 4941.2 4958.8 5025.6 5088.8 391.0 401.8 403.4 407.2 411.1 3255.8 3379.0 3477.2 3576.6 3627.6 8913.6 9549.4 9570.0 9594.4 9616.5 9479.6 9482.1 9484.5 9517.9 9535.9 7214.6 7424.5 7436.6 7462.2 7470.9 5116.0 5181.4 5284.5 5325.4 5511.6 8903.7 8930.5 8952.0 9020.9 9044.8 8810.0 9039.8 9063.0 9130.3 9132.1 6609.2 6773.6 7459.4 7552.5 7682.7 7192.0 7317.3 7367.9 7571.7 7582.5 6759.6 6777.3 6822.7 6870.7 7085.6 6686.1 6714.2 6853.1 6858.0 7012.2 6006.1 6103.8 6104.3 6105.0 6106.8 4384.2 4394.1 4450.4 4454.2 4530.0 4408.7 4439.0 4455.5 4485.3 4522.6 20:47:41 INFO - PROCESS | 26641 | 20:47:41 INFO - PROCESS | 26641 | [#4] prototype.html Cycles:180 Average:4183.51 Median:4833.18 stddev:1221.22 (25.3%) stddev-sans-first:1189.04 20:47:41 INFO - PROCESS | 26641 | Values: 283.2 284.7 290.3 291.5 292.1 4833.5 4853.2 4860.5 4861.2 4896.2 4798.0 4808.5 4819.3 4832.9 4856.8 3522.2 3631.7 3679.2 3772.3 3782.6 3784.9 3787.4 3788.0 3792.4 3797.6 3716.6 3719.2 3726.3 3731.2 3787.3 3519.9 3622.5 3640.6 3725.9 3751.5 3303.4 3310.1 3313.3 3319.8 3328.2 4605.6 4652.9 4663.2 4670.8 4691.0 4173.9 4269.6 4288.8 4289.5 4318.4 4968.9 5005.2 5014.9 5017.7 5031.5 3570.6 3600.1 3610.5 3616.6 3618.0 5143.2 5182.9 5262.6 5264.9 5296.7 3607.7 3640.6 3649.9 3658.4 3668.4 3670.9 3688.4 3702.3 3716.4 3722.6 4236.8 4269.1 4275.6 4282.3 4282.6 4962.0 5006.0 5062.2 5085.9 5135.7 1279.1 1301.4 1309.5 1315.9 1316.6 784.8 810.4 832.5 841.7 844.6 4267.8 4317.5 4410.4 4462.8 4469.2 5177.3 5179.8 5182.3 5190.5 5199.1 4464.6 4468.9 4470.2 4485.5 4498.3 2601.6 2745.1 2757.1 2762.7 2764.3 4904.6 4914.7 4948.4 4950.4 4955.0 5007.8 5234.3 5366.3 5369.7 5369.9 4819.7 4844.6 4856.4 4872.7 4915.8 5191.5 5196.4 5206.3 5247.2 5271.5 4976.5 5133.5 5136.5 5138.6 5174.6 4852.0 4853.7 4886.1 4927.6 4928.2 3688.3 3691.3 3696.4 3698.9 3724.0 4933.4 5149.5 5153.9 5205.3 5213.9 4964.0 4994.4 5027.8 5055.9 5060.2 5053.8 5064.7 5069.5 5077.4 5085.4 4699.7 4936.2 4940.9 4973.8 5013.8 4892.5 4897.7 5008.9 5079.6 5119.4 4996.3 4997.8 5008.5 5012.8 5016.8 20:47:41 INFO - PROCESS | 26641 | 20:47:41 INFO - PROCESS | 26641 | [#5] yui.html Cycles:180 Average:17698.92 Median:61947.19 stddev:26756.49 (43.2%) stddev-sans-first:26800.60 20:47:41 INFO - PROCESS | 26641 | Values: 559.1 584.2 591.1 608.3 613.1 12191.0 12928.8 13286.1 13308.5 13309.9 12147.7 12502.8 12561.4 12637.7 12646.6 605.7 734.8 761.1 764.7 765.5 617.9 735.2 756.8 761.2 765.3 812.9 813.5 816.2 816.2 816.5 631.3 808.6 808.9 809.2 809.6 477.5 559.0 577.7 577.9 580.8 12142.9 12153.2 12161.5 12170.1 12182.6 11189.9 11705.5 11731.4 11998.1 12227.8 10485.5 10669.5 10728.2 10783.7 10793.5 3759.8 3803.7 3834.3 3854.6 3888.3 61578.7 61847.4 61868.7 62025.7 62156.4 9219.3 9246.4 9497.7 9566.5 9982.6 17262.9 17275.5 17302.0 17415.5 17443.2 6321.0 6384.7 6438.5 6512.1 6769.3 3390.9 3393.6 3460.7 3488.4 3546.6 2728.5 2801.6 2803.2 2810.6 2813.6 480.4 491.7 495.2 527.6 559.3 443.4 491.5 492.6 504.1 512.5 7228.6 7498.4 7548.4 7652.3 7808.1 419.3 472.2 485.7 489.8 497.8 3503.6 3521.4 3532.8 3675.3 3697.8 58151.0 94247.5 98038.0 111171.0 111261.0 84984.0 86872.6 87719.0 88022.0 89310.6 82630.6 83242.0 84024.0 84248.6 84920.7 6764.5 6833.1 6863.5 7057.5 7081.9 48847.8 49331.5 49743.5 50678.2 51481.0 60151.7 68959.7 69585.0 69739.7 73109.0 8436.7 8665.1 8798.0 8928.3 8977.7 9952.8 9952.9 9980.7 10047.0 10274.3 9170.6 9429.0 9510.6 9612.5 9990.1 9423.4 9559.7 9590.3 9737.0 9917.6 9127.1 9264.8 9393.8 9518.4 9806.4 7981.4 8219.2 8297.1 8315.8 8354.5 8064.8 8079.6 8245.5 8480.7 8527.2 20:47:41 INFO - PROCESS | 26641 | -------- Summary: end -------- 20:47:41 INFO - PROCESS | 26641 | 20:47:42 INFO - TEST-INFO | 26641: exit 0 20:47:42 INFO - TEST-OK | dromaeo_css | took 1121235ms 20:47:42 INFO - TEST-START | kraken 20:47:42 INFO - operating with platform_type : linux_ 20:47:42 INFO - Initialising browser for kraken test... 20:47:42 INFO - TEST-INFO | started process 26948 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHZk7NN/profile http://localhost:43929/getInfo.html) 20:47:46 INFO - PROCESS | 26948 | __metrics Screen width/height:1600/1200 20:47:46 INFO - PROCESS | 26948 | colorDepth:24 20:47:46 INFO - PROCESS | 26948 | Browser inner width/height: 1024/697 20:47:46 INFO - PROCESS | 26948 | __metrics 20:47:47 INFO - PROCESS | 26948 | 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" 20:47:47 INFO - PROCESS | 26948 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:47:48 INFO - PROCESS | 26948 | console.error: PushService: 20:47:48 INFO - PROCESS | 26948 | stateChangeProcessEnqueue: Error transitioning state 20:47:48 INFO - PROCESS | 26948 | UnknownError 20:47:48 INFO - TEST-INFO | 26948: exit 0 20:47:48 INFO - Browser initialized. 20:47:48 INFO - Running cycle 1/1 for kraken test... 20:47:48 INFO - TEST-INFO | started process 27031 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHZk7NN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:48:00 INFO - PROCESS | 27031 | RSS: Main: 174972928 20:48:00 INFO - PROCESS | 27031 | 20:48:03 INFO - PROCESS | 27031 | Cycle 1(1): loaded http://localhost:43929/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43929/tests/kraken/driver.html?testName=audio-beat-detection) 20:48:04 INFO - PROCESS | 27031 | RSS: Main: 238350336 20:48:04 INFO - PROCESS | 27031 | 20:48:07 INFO - PROCESS | 27031 | Cycle 1(1): loaded http://localhost:43929/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43929/tests/kraken/driver.html?testName=audio-dft) 20:48:08 INFO - PROCESS | 27031 | RSS: Main: 218423296 20:48:08 INFO - PROCESS | 27031 | 20:48:11 INFO - PROCESS | 27031 | Cycle 1(1): loaded http://localhost:43929/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43929/tests/kraken/driver.html?testName=audio-fft) 20:48:12 INFO - PROCESS | 27031 | RSS: Main: 300761088 20:48:12 INFO - PROCESS | 27031 | 20:48:14 INFO - PROCESS | 27031 | Cycle 1(1): loaded http://localhost:43929/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43929/tests/kraken/driver.html?testName=audio-oscillator) 20:48:14 INFO - PROCESS | 27031 | RSS: Main: 210132992 20:48:14 INFO - PROCESS | 27031 | 20:48:17 INFO - PROCESS | 27031 | Cycle 1(1): loaded http://localhost:43929/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43929/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:48:17 INFO - PROCESS | 27031 | RSS: Main: 213614592 20:48:17 INFO - PROCESS | 27031 | 20:48:20 INFO - PROCESS | 27031 | Cycle 1(1): loaded http://localhost:43929/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43929/tests/kraken/driver.html?testName=imaging-darkroom) 20:48:21 INFO - PROCESS | 27031 | RSS: Main: 250953728 20:48:21 INFO - PROCESS | 27031 | 20:48:24 INFO - PROCESS | 27031 | Cycle 1(1): loaded http://localhost:43929/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43929/tests/kraken/driver.html?testName=imaging-desaturate) 20:48:25 INFO - PROCESS | 27031 | RSS: Main: 244793344 20:48:25 INFO - PROCESS | 27031 | 20:48:28 INFO - PROCESS | 27031 | Cycle 1(1): loaded http://localhost:43929/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43929/tests/kraken/driver.html?testName=json-parse-financial) 20:48:29 INFO - PROCESS | 27031 | RSS: Main: 247472128 20:48:29 INFO - PROCESS | 27031 | 20:48:30 INFO - PROCESS | 27031 | Cycle 1(1): loaded http://localhost:43929/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43929/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:48:31 INFO - PROCESS | 27031 | RSS: Main: 210853888 20:48:31 INFO - PROCESS | 27031 | 20:48:33 INFO - PROCESS | 27031 | Cycle 1(1): loaded http://localhost:43929/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43929/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:48:33 INFO - PROCESS | 27031 | RSS: Main: 218886144 20:48:33 INFO - PROCESS | 27031 | 20:48:36 INFO - PROCESS | 27031 | Cycle 1(1): loaded http://localhost:43929/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43929/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:48:36 INFO - PROCESS | 27031 | RSS: Main: 223424512 20:48:36 INFO - PROCESS | 27031 | 20:48:39 INFO - PROCESS | 27031 | Cycle 1(1): loaded http://localhost:43929/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43929/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:48:40 INFO - PROCESS | 27031 | RSS: Main: 218128384 20:48:40 INFO - PROCESS | 27031 | 20:48:43 INFO - PROCESS | 27031 | Cycle 1(1): loaded http://localhost:43929/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43929/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:48:43 INFO - PROCESS | 27031 | RSS: Main: 221163520 20:48:43 INFO - PROCESS | 27031 | 20:48:45 INFO - PROCESS | 27031 | Cycle 1(1): loaded http://localhost:43929/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43929/tests/kraken/driver.html?testName=ai-astar) 20:48:45 INFO - PROCESS | 27031 | RSS: Main: 272547840 20:48:45 INFO - PROCESS | 27031 | 20:48:45 INFO - PROCESS | 27031 | __start_tp_report 20:48:45 INFO - PROCESS | 27031 | _x_x_mozilla_page_load 20:48:45 INFO - PROCESS | 27031 | _x_x_mozilla_page_load_details 20:48:45 INFO - PROCESS | 27031 | |i|pagename|runs| 20:48:45 INFO - PROCESS | 27031 | |0;ai-astar;112;116;116;115;117;115;115;114;116;116 20:48:45 INFO - PROCESS | 27031 | |1;audio-beat-detection;154;126;125;186;124;131;130;124;158;129 20:48:45 INFO - PROCESS | 27031 | |2;audio-dft;163;160;161;162;160;163;162;162;163;162 20:48:45 INFO - PROCESS | 27031 | |3;audio-fft;76;76;75;126;77;76;76;76;111;79 20:48:45 INFO - PROCESS | 27031 | |4;audio-oscillator;84;83;115;84;85;83;106;84;83;114 20:48:45 INFO - PROCESS | 27031 | |5;imaging-gaussian-blur;119;117;117;117;116;117;116;117;117;117 20:48:45 INFO - PROCESS | 27031 | |6;imaging-darkroom;147;146;146;146;147;146;146;146;147;146 20:48:45 INFO - PROCESS | 27031 | |7;imaging-desaturate;95;96;96;95;95;96;96;96;95;96 20:48:45 INFO - PROCESS | 27031 | |8;json-parse-financial;66;63;63;64;63;65;64;65;65;65 20:48:45 INFO - PROCESS | 27031 | |9;json-stringify-tinderbox;68;67;67;68;66;67;68;67;67;67 20:48:45 INFO - PROCESS | 27031 | |10;stanford-crypto-aes;83;86;89;83;86;87;83;82;82;84 20:48:45 INFO - PROCESS | 27031 | |11;stanford-crypto-ccm;142;134;136;132;129;135;147;142;186;142 20:48:45 INFO - PROCESS | 27031 | |12;stanford-crypto-pbkdf2;177;170;177;176;171;172;174;175;173;177 20:48:45 INFO - PROCESS | 27031 | |13;stanford-crypto-sha256-iterative;69;70;70;70;68;68;73;68;69;73 20:48:45 INFO - PROCESS | 27031 | __end_tp_report 20:48:45 INFO - PROCESS | 27031 | __start_cc_report 20:48:45 INFO - PROCESS | 27031 | _x_x_mozilla_cycle_collect,1973 20:48:45 INFO - PROCESS | 27031 | __end_cc_report 20:48:45 INFO - PROCESS | 27031 | __startTimestamp1474429725899__endTimestamp 20:48:45 INFO - PROCESS | 27031 | 20:48:45 INFO - PROCESS | 27031 | ------- Summary: start ------- 20:48:45 INFO - PROCESS | 27031 | Number of tests: 14 20:48:45 INFO - PROCESS | 27031 | 20:48:45 INFO - PROCESS | 27031 | [#0] ai-astar Cycles:10 Average:115.20 Median:116.00 stddev:1.40 (1.2%) stddev-sans-first:0.88 20:48:45 INFO - PROCESS | 27031 | Values: 112.0 116.0 116.0 115.0 117.0 115.0 115.0 114.0 116.0 116.0 20:48:45 INFO - PROCESS | 27031 | 20:48:45 INFO - PROCESS | 27031 | [#1] audio-beat-detection Cycles:10 Average:138.70 Median:130.50 stddev:20.69 (15.9%) stddev-sans-first:21.20 20:48:45 INFO - PROCESS | 27031 | Values: 154.0 126.0 125.0 186.0 124.0 131.0 130.0 124.0 158.0 129.0 20:48:45 INFO - PROCESS | 27031 | 20:48:45 INFO - PROCESS | 27031 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.14 (0.7%) stddev-sans-first:1.12 20:48:45 INFO - PROCESS | 27031 | Values: 163.0 160.0 161.0 162.0 160.0 163.0 162.0 162.0 163.0 162.0 20:48:45 INFO - PROCESS | 27031 | 20:48:45 INFO - PROCESS | 27031 | [#3] audio-fft Cycles:10 Average:84.80 Median:76.00 stddev:18.14 (23.9%) stddev-sans-first:18.96 20:48:45 INFO - PROCESS | 27031 | Values: 76.0 76.0 75.0 126.0 77.0 76.0 76.0 76.0 111.0 79.0 20:48:45 INFO - PROCESS | 27031 | 20:48:45 INFO - PROCESS | 27031 | [#4] audio-oscillator Cycles:10 Average:92.10 Median:83.50 stddev:13.71 (16.4%) stddev-sans-first:14.23 20:48:45 INFO - PROCESS | 27031 | Values: 84.0 83.0 115.0 84.0 85.0 83.0 106.0 84.0 83.0 114.0 20:48:45 INFO - PROCESS | 27031 | 20:48:45 INFO - PROCESS | 27031 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.82 (0.7%) stddev-sans-first:0.44 20:48:45 INFO - PROCESS | 27031 | Values: 119.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 20:48:45 INFO - PROCESS | 27031 | 20:48:45 INFO - PROCESS | 27031 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 20:48:45 INFO - PROCESS | 27031 | Values: 147.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 147.0 146.0 20:48:45 INFO - PROCESS | 27031 | 20:48:45 INFO - PROCESS | 27031 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 20:48:45 INFO - PROCESS | 27031 | Values: 95.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 96.0 20:48:45 INFO - PROCESS | 27031 | 20:48:45 INFO - PROCESS | 27031 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:65.00 stddev:1.06 (1.6%) stddev-sans-first:0.93 20:48:45 INFO - PROCESS | 27031 | Values: 66.0 63.0 63.0 64.0 63.0 65.0 64.0 65.0 65.0 65.0 20:48:45 INFO - PROCESS | 27031 | 20:48:45 INFO - PROCESS | 27031 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 20:48:45 INFO - PROCESS | 27031 | Values: 68.0 67.0 67.0 68.0 66.0 67.0 68.0 67.0 67.0 67.0 20:48:45 INFO - PROCESS | 27031 | 20:48:45 INFO - PROCESS | 27031 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:85.00 stddev:2.37 (2.8%) stddev-sans-first:2.45 20:48:45 INFO - PROCESS | 27031 | Values: 83.0 86.0 89.0 83.0 86.0 87.0 83.0 82.0 82.0 84.0 20:48:45 INFO - PROCESS | 27031 | 20:48:45 INFO - PROCESS | 27031 | [#11] stanford-crypto-ccm Cycles:10 Average:142.50 Median:142.00 stddev:16.25 (11.4%) stddev-sans-first:17.23 20:48:45 INFO - PROCESS | 27031 | Values: 142.0 134.0 136.0 132.0 129.0 135.0 147.0 142.0 186.0 142.0 20:48:45 INFO - PROCESS | 27031 | 20:48:45 INFO - PROCESS | 27031 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.20 Median:175.50 stddev:2.62 (1.5%) stddev-sans-first:2.57 20:48:45 INFO - PROCESS | 27031 | Values: 177.0 170.0 177.0 176.0 171.0 172.0 174.0 175.0 173.0 177.0 20:48:45 INFO - PROCESS | 27031 | 20:48:45 INFO - PROCESS | 27031 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.00 stddev:1.87 (2.7%) stddev-sans-first:1.96 20:48:45 INFO - PROCESS | 27031 | Values: 69.0 70.0 70.0 70.0 68.0 68.0 73.0 68.0 69.0 73.0 20:48:45 INFO - PROCESS | 27031 | -------- Summary: end -------- 20:48:45 INFO - PROCESS | 27031 | 20:48:47 INFO - TEST-INFO | 27031: exit 0 20:48:47 INFO - TEST-OK | kraken | took 65109ms 20:48:47 INFO - SUITE-END | took 1186s 20:48:47 INFO - Completed test suite (00:19:46) 20:48:47 INFO - javascript benchmark 20:48:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2556.7954563634903, 2589.1585234798695, 2619.1356852238764, 2628.5662865627173, 2641.247244535308, 4535.705179163352, 4622.1217968586025, 4731.313959475874, 4745.050989802036, 4746.857594272173, 4646.744429056401, 4670.719756814602, 4681.344611754357, 4688.601468875149, 4699.271612900006, 4262.360645903108, 4272.401863739079, 4306.978465107686, 4327.870163895088, 4402.911941761179, 4350.912981740364, 4402.3836662867225, 4414.359917811916, 4431.512533621299, 4485.842995495158, 4267.0, 4318.676099292566, 4333.133373325331, 4357.41174941382, 4357.934630980538, 4258.467691538558, 4280.464941882265, 4360.149770794696, 4375.14684636496, 4379.627731642814, 4287.571242875719, 4298.613124818781, 4342.804573794156, 4348.782560871975, 4364.432623758923, 4621.399218101626, 4656.790444430008, 4685.273782563708, 4697.107549565571, 4758.809647614091, 4951.207806750903, 4982.60139188864, 5021.648484606079, 5041.243813427978, 5048.5203905628905, 5029.1953287473825, 5030.949690503085, 5032.47159048302, 5080.669756465818, 5087.49125087492, 4676.69601475903, 4678.391809064799, 4683.859484215479, 4687.71873687573, 4746.288056791509, 5035.924461133086, 5102.464241254689, 5120.359955005624, 5122.667026643257, 5184.351956005499, 4885.975570122127, 4917.385326834145, 4947.233178857283, 4968.279599458058, 4986.401631804207, 5013.373328333958, 5014.623903207201, 5016.247562865527, 5026.79892804291, 5092.821751238763, 5051.166557518042, 5064.215046667772, 5065.670731402521, 5069.264956581275, 5090.694558326512, 4856.757162141878, 4898.755062246873, 5056.595472362203, 5061.392632884077, 5069.44236134025, 4292.527821939584, 4313.568643135724, 4317.11499142675, 4324.286492728727, 4328.04782947751, 3724.0689827543115, 3752.2870654575545, 3756.73702840804, 3773.4905787718308, 3777.6411240932066, 4298.63461605767, 4343.261645520269, 4384.232759267115, 4389.670774691911, 4431.711938723973, 5034.597232221414, 5077.923831142536, 5092.592592592584, 5098.311727916758, 5168.9224661630105, 4366.323219900921, 4397.934030989538, 4400.9559904401185, 4401.559844015637, 4450.910981780346, 4585.876460267189, 4587.472440669299, 4594.839180628662, 4597.977010114928, 4647.837325693585, 4566.3150527420485, 4604.5165257648805, 4710.717356958594, 4741.596964257938, 4752.691075080109, 5049.0, 5055.772490237875, 5056.292119103255, 5058.9494105058475, 5103.10695628271, 4743.691660042086, 4745.691530050535, 4745.810167593258, 4794.808207671654, 4802.039592081667, 4872.171730805842, 4884.096442158212, 4913.65604407688, 4945.406551213733, 4978.775955082103, 5049.065922804293, 5049.747512624427, 5050.949490505048, 5096.464871188472, 5108.259302401057, 4895.0, 4929.841487250422, 4930.063287975417, 4930.841252305633, 4996.6002719783055, 4740.288956656391, 4828.227483602606, 4875.219964805614, 4877.707337559757, 4946.653734238569, 4769.809207631656, 4863.051704917507, 4866.48901865299, 4922.483139270468, 4931.334269873521, 4901.852944411673, 4966.701997880139, 4968.205087186033, 4985.127602669446, 5046.545810877039, 4682.297655351725, 4783.593394561502, 4817.373741413734, 4850.320955066223, 4867.610591152628], "value": 4627.497728303358, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.6956043736383, 571.6798592788039, 575.5280669850722, 581.2153592649926, 581.8138195777353, 27850.721492785065, 28820.56769148462, 37968.620313796855, 39043.60956390442, 39161.41257881134, 39422.21155576887, 39831.800840995755, 39860.80069599655, 39873.80063099688, 39881.800590997074, 7533.698652053911, 7687.500312479699, 7692.499987500794, 7696.461247712662, 7697.538147711127, 7616.124145723257, 7715.189905059972, 7724.729634462795, 7724.884126738103, 7735.8066048348965, 7736.497127686711, 7781.144074151839, 7783.066032076159, 7785.1436342002335, 7790.727324543642, 7700.614969251515, 7717.884231736529, 7737.651805668758, 7747.922520774805, 7755.418343624195, 7518.548887066739, 7570.129435114977, 7575.0, 7581.54510729358, 7585.772426827204, 36831.263374732356, 37201.0, 37204.0, 37272.44091338632, 37280.44079338812, 2764.3227409284855, 2777.5833624956217, 3008.849557522137, 3046.3907218556155, 3072.7080927311868, 27671.30821729453, 27680.446391072066, 29002.854985725146, 29065.854670726512, 31171.68828311733, 3453.913652158716, 3504.842282097312, 3524.22467057247, 3532.717382609385, 3601.927961440783, 246465.0, 248795.0, 249107.9999999982, 249664.0, 251807.0, 55744.72127639417, 56427.71786141043, 56455.0, 56562.43437565654, 56569.0, 32675.183120421705, 33642.49536256958, 33730.831345843115, 35485.29029419397, 35497.82251088728, 15277.541673749805, 15528.689426211413, 15557.29992150356, 15570.688586228212, 15577.688446231012, 11283.266587671775, 11432.657020289405, 11448.542058317575, 11448.599299024494, 11451.198416110792, 18637.81362186388, 18761.0, 18787.15457804402, 18830.90584547096, 18894.0, 7181.605011724405, 7188.460865435113, 7191.496595238388, 7212.531185472927, 7235.0, 752.6537792615459, 892.7187935800332, 934.7663084228943, 940.4545363689044, 944.976375590602, 26537.0, 26775.330616734347, 27664.723352766618, 27815.443691126467, 27828.165155045383, 768.6041688530412, 866.7139843851514, 898.1422741282059, 955.1069749783974, 1001.0040010189762, 12862.871371286354, 15728.449504267295, 16380.180990950405, 16384.83615163833, 16824.978231123274, 372282.0, 377320.0, 377913.0, 378437.0, 378723.0, 48886.0, 48980.51019489759, 49193.26210106851, 49254.0, 49360.0, 1056.6196169379018, 1078.9784204316027, 1167.1888037813637, 1175.8471398718111, 1182.2079206931376, 26334.0, 28859.85570072136, 29910.25224369408, 31080.378392431572, 31786.682133178372, 45337.0, 45852.0, 45933.31100033569, 45960.54039459563, 45985.77007115077, 316352.0, 318107.0, 318462.0, 320778.0, 321111.0, 25198.370040749127, 25358.492830142925, 25746.227613171635, 25940.092096776523, 25958.159414132424, 39969.200615986934, 40772.38841417322, 41306.380404293355, 41413.378799317434, 41962.0, 34062.0, 34524.48213276853, 34612.65387346094, 35044.82477587596, 35424.46863297001, 34795.478067828495, 35127.0, 35609.1097722559, 35798.8210058948, 35883.82058089693, 34128.31743365168, 34583.13542161466, 35041.64958350384, 35301.1174720634, 35609.0, 30789.846050769604, 33287.0, 33341.83329083339, 33351.49972750362, 33510.66489335075, 24387.26838194857, 24850.50298994046, 25139.54848752278, 25499.617505737056, 25772.8711356442], "value": 17223.330290472226, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.2254926415565, 360.7258483552501, 365.74946161879114, 369.16200225488143, 388.2952441319006, 12343.876561234385, 15776.447824326136, 15779.999999999985, 16533.834661653378, 17757.378491752792, 16024.519264422057, 16500.587485312873, 17287.567810804736, 17470.912645436754, 17477.47567572972, 4968.205087186042, 5059.595232381401, 5096.261042148886, 5096.974515127419, 5117.692938423688, 3710.239400922804, 4958.082754690376, 5130.486951304858, 5134.435212126663, 5136.820211292606, 3867.1105645701505, 5610.354809196933, 5868.354481007086, 5896.498797602209, 5994.46049855513, 5207.531322181022, 5480.205370221335, 5976.88046239075, 5977.7608895644125, 5978.940210597903, 5415.268938693265, 5420.945790542123, 5422.593305502103, 5425.701586412746, 5426.8371948841595, 11902.464389102424, 12002.759944801055, 12308.26150430977, 12600.306983115925, 12672.556460523838, 1959.9314024009234, 1982.7422435083347, 2132.986831255157, 2207.878566678832, 2286.9480039181994, 9231.769205769842, 9467.289953253465, 9586.520673966343, 11989.93196600789, 12490.875091249152, 1678.7230107032326, 1746.1356628468861, 1746.903920284384, 1759.7888253409544, 1838.1366126194262, 63604.0, 69437.65281173562, 69824.30175698228, 70174.29825701729, 71235.28764712339, 9492.677562853085, 9866.0, 10141.695749127539, 10151.94924025375, 10363.170946324275, 14015.789763153562, 14031.579052628438, 14032.158070515801, 14035.298235088409, 14044.71910561783, 7308.488405811542, 7506.099268087864, 7627.809304767426, 7707.961460192775, 7741.7677469676, 7087.82280442993, 7217.684526039715, 7311.341979221896, 7420.777376678709, 7428.962855185798, 4125.092479654471, 4254.808533615995, 4258.552851950562, 4393.231184542692, 4420.270655341833, 1729.5848996240811, 1736.8089510153873, 1754.2982806877096, 1771.5305444057335, 1796.9011704356385, 790.8457850719054, 807.4590024683476, 823.7940514871282, 840.1514470384956, 868.487592320534, 15860.52418427449, 16135.19324033817, 16745.07902065374, 17241.655166896842, 17658.205380757896, 769.4882902869641, 805.6777289084413, 805.8549461097059, 818.300353198019, 843.6920524008692, 9269.0, 9406.16579766939, 9785.36395134314, 9802.313838031268, 9818.013156516683, 376184.0, 411072.0, 413166.0, 415360.0, 416303.0, 78404.8472486754, 80323.59838200889, 80960.0, 81484.59257703673, 83226.58386708148, 850.9531975741394, 870.2472361407464, 871.1636828644446, 874.6676263020139, 880.5245167609419, 14938.477153299582, 15049.75435194382, 15297.46458873934, 15374.846251537341, 15996.680066398374, 36323.27353452969, 36478.45282320714, 37035.81482092572, 37204.44193337156, 37213.62786372102, 49806.0, 50120.24819627781, 50371.24443133282, 50400.0, 50427.74786126046, 7554.206808285051, 7707.383409327353, 7893.131755506774, 8082.393820463606, 8087.069986951341, 11096.778064438504, 11403.258788178742, 11592.710182245512, 11791.528338866348, 12219.26684398939, 9696.9030309696, 9868.85196722064, 10363.844542332023, 10493.580256789643, 10893.509792059218, 10120.493975301353, 10311.278210525492, 10435.269531132748, 10609.840852387375, 10785.946070269598, 10258.43578603184, 10408.375497470177, 10476.68569942903, 10549.419781912069, 10878.184136189975, 6789.355011273921, 7109.360157585842, 7152.9985801988805, 7169.068021157216, 8066.516009039242, 8735.56322183901, 10194.286399951932, 10316.948415257875, 10704.571817127227, 10780.083692885879], "value": 8103.782517775309, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1243.9378031098443, 1368.7194125204335, 1400.2788563889596, 1452.4262916148123, 1676.1870492810992, 6872.415844653205, 7830.4518683692095, 8102.756917292476, 8186.713465028725, 8224.0, 7963.840723185533, 8088.95955520223, 8105.959470202641, 8106.716264930728, 8111.75664730059, 2172.7066845975787, 2201.691763153152, 2207.260567709819, 2207.3598656389627, 2207.75714671386, 2104.1057550541036, 2167.2522979572022, 2183.4541364658835, 2185.694002839604, 2194.6049711052005, 2134.3063504361066, 2162.243214874797, 2169.40341406113, 2169.5877783221217, 2195.3413975807193, 2069.4102180878454, 2085.614161380142, 2085.9165633374646, 2087.4155236533793, 2088.1960445228547, 2069.6688529835305, 2122.373899699592, 2125.777677835251, 2130.8614940028847, 2139.240569597786, 7829.1779363166615, 7951.880721789178, 8034.116247212802, 8038.758837234892, 8113.0, 4246.7027308088445, 4395.648348132142, 4406.405135306724, 4407.625351845097, 4408.228560002019, 2595.50685369781, 2706.2963629456285, 2747.4230411613585, 2755.586662000696, 2761.295869553271, 899.8065415935605, 905.1129892705186, 915.9862602060974, 918.196577994255, 927.4898805656929, 10405.21960852939, 10546.683599492027, 10609.15126789855, 10622.521986510626, 10657.946710266398, 3733.0, 3917.7061720371084, 4024.5774193709826, 4052.8176232069627, 4077.857274995361, 8418.074011858691, 8418.452800567944, 8430.24127828486, 8430.915690843136, 8436.662533498715, 4411.02957349389, 4413.3821265022925, 4414.690971632019, 4423.823047078081, 4434.800433980478, 3657.122290650225, 3762.3227818992846, 3943.7830919299713, 4110.917781644351, 4120.938185927213, 3396.3207358528393, 3406.67636574525, 3495.545579074704, 3553.2715793262837, 3556.253186830743, 1032.7934413117407, 1041.6198087697935, 1045.7072019834307, 1051.9947400263102, 1055.150603763962, 723.2731105239201, 760.3992845651873, 778.9143194248628, 781.1368437876065, 781.2578050851714, 4880.6095512358925, 4941.209406494943, 4958.826441074617, 5025.572826309804, 5088.796448142033, 390.958949310324, 401.76898283486526, 403.41303403547766, 407.21407683171765, 411.06072624053894, 3255.7558183135884, 3379.0369744622662, 3477.217626034122, 3576.5529308836394, 3627.5828279748166, 8913.598888050054, 9549.427034377959, 9570.0, 9594.376365536218, 9616.51917404127, 9479.620815167316, 9482.099200575934, 9484.478353690476, 9517.904820951702, 9535.856962145574, 7214.567125972459, 7424.480286379901, 7436.553806771611, 7462.216467270967, 7470.925290747023, 5116.0, 5181.35233095863, 5284.471552844839, 5325.414204437431, 5511.559075273888, 8903.688370906988, 8930.508822014852, 8951.955240223757, 9020.864687029569, 9044.824172857487, 8810.0, 9039.774005649911, 9062.954685226532, 9130.269578433577, 9132.132447417485, 6609.239937407259, 6773.593584384756, 7459.36595389398, 7552.471327007057, 7682.6926922924695, 7191.964040179766, 7317.341439270278, 7367.889481657887, 7571.697132114654, 7582.54504729718, 6759.5606285591275, 6777.254502004874, 6822.692978815866, 6870.690818913061, 7085.645717713991, 6686.06395104676, 6714.2278637955305, 6853.143357080365, 6858.0, 7012.193597736122, 6006.069059295816, 6103.84740381494, 6104.32852386246, 6105.0, 6106.847328816815, 4384.188925048876, 4394.143142087262, 4450.376947227326, 4454.242778727689, 4530.0486897750525, 4408.6693497987135, 4438.955610443854, 4455.487618923865, 4485.304777759453, 4522.615577675934], "value": 3971.1847853063846, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.1533714194558, 284.7223956642273, 290.32644265304504, 291.51317300108815, 292.0915951391174, 4833.453294945614, 4853.199222128349, 4860.4896485869, 4861.173600487917, 4896.2410826321975, 4797.96843678609, 4808.489802444218, 4819.32529445877, 4832.903341933159, 4856.781444834982, 3522.1546828761043, 3631.654992775682, 3679.22736225393, 3772.2832661794173, 3782.565005024416, 3784.8615532224344, 3787.431885217212, 3788.0, 3792.374258247386, 3797.563280222782, 3716.591174970751, 3719.163188282642, 3726.273376691546, 3731.160488890005, 3787.3182827091114, 3519.8592056317843, 3622.5290712207507, 3640.5631324240994, 3725.9068523286865, 3751.4560388743616, 3303.4219011672863, 3310.1062713067577, 3313.2545177335146, 3319.8008119512906, 3328.2012317043977, 4605.562471565229, 4652.883677908046, 4663.2305669564485, 4670.7664616769025, 4691.0, 4173.895652608679, 4269.594388533084, 4288.785560721952, 4289.506706728735, 4318.4170137031415, 4968.8757781055765, 5005.224190250517, 5014.874628134289, 5017.673851199696, 5031.52200540948, 3570.589382221026, 3600.135967367839, 3610.5125808016105, 3616.594964348705, 3617.981910090459, 5143.151380022292, 5182.948170518284, 5262.578993680497, 5264.947350526484, 5296.702307934542, 3607.7113830893463, 3640.6177351378255, 3649.94525082124, 3658.378075727133, 3668.3947148720695, 3670.871519496805, 3688.39141541648, 3702.2595480903387, 3716.3682174030478, 3722.590515043343, 4236.830526778956, 4269.146170765797, 4275.636570891447, 4282.314829627245, 4282.571742825692, 4961.982793527318, 5005.974970125126, 5062.164742817467, 5085.9147749422555, 5135.717535535581, 1279.0918447901909, 1301.4208677138583, 1309.5482058689736, 1315.9210447372998, 1316.5918565244613, 784.7645706288091, 810.3557671651051, 832.5129799067493, 841.7096101844854, 844.5692696724592, 4267.8079486423185, 4317.460317460317, 4410.360497727812, 4462.843800466968, 4469.21788686985, 5177.3269474968765, 5179.766910489037, 5182.274481572583, 5190.480951904779, 5199.142141546602, 4464.598186163261, 4468.865934021985, 4470.195364834361, 4485.484169320504, 4498.280275155959, 2601.596752503365, 2745.1490038088255, 2757.1389312214174, 2762.6822915364587, 2764.3365592258115, 4904.583110435653, 4914.680545764585, 4948.38145231846, 4950.415866922623, 4954.9752251238515, 5007.774650140753, 5234.293370395024, 5366.275552800322, 5369.6509726867625, 5369.919451208235, 4819.662623616313, 4844.636652251095, 4856.41722993236, 4872.658913875995, 4915.778789954461, 5191.521680474167, 5196.402413722471, 5206.271122042841, 5247.192751877879, 5271.499207575274, 4976.5023497649945, 5133.512316329943, 5136.512031357015, 5138.588912887035, 5174.6119041072825, 4852.0, 4853.733044682435, 4886.144924638245, 4927.630427717864, 4928.162212423968, 3688.3360995021153, 3691.2617476505343, 3696.445533170046, 3698.852045918133, 3723.9813800931906, 4933.358663373739, 5149.510796474329, 5153.943441594539, 5205.297284866646, 5213.869653258699, 4964.0, 4994.400671919393, 5027.824026159067, 5055.862430953006, 5060.1903695408555, 5053.823116191063, 5064.696118232918, 5069.467705890828, 5077.365329333833, 5085.38102877026, 4699.671023028492, 4936.234883593049, 4940.8764780880765, 4973.776180071833, 5013.793930670493, 4892.48628893961, 4897.702108941062, 5008.899822003613, 5079.593632509464, 5119.411267704113, 4996.325496057985, 4997.775100120431, 5008.549230569266, 5012.7718708916545, 5016.799328026838], "value": 3790.6148206609532, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.1054313099041, 584.2404873664235, 591.1221835574172, 608.2700759089092, 613.129356314034, 12191.0, 12928.771766682174, 13286.13640113392, 13308.534201302957, 13309.933450332746, 12147.696307592314, 12502.81245781314, 12561.371931403439, 12637.684057898558, 12646.557370492035, 605.7032054293387, 734.794257607868, 761.075293518375, 764.6788348893479, 765.4985984180371, 617.9104029915682, 735.1692587376284, 756.8486302739474, 761.2121454294806, 765.2500549461531, 812.9227723366271, 813.5484805932705, 816.2408959667507, 816.2408959667507, 816.5223344343566, 631.3307893632764, 808.59974312715, 808.8746244332109, 809.2069771623812, 809.550699361854, 477.46762359968733, 558.9776408943637, 577.656294504769, 577.8757567123089, 580.8373655376502, 12142.939285303517, 12153.210041347284, 12161.5135394585, 12170.087243456775, 12182.634520964386, 11189.888101118966, 11705.473253703518, 11731.413429328584, 11998.120451091763, 12227.816582751266, 10485.475726213659, 10669.466526673712, 10728.195385346053, 10783.730406739816, 10793.460326983697, 3759.7744135351695, 3803.744764227798, 3834.2523207974455, 3854.5759966403675, 3888.2612303662213, 61578.69210653918, 61847.38152618461, 61868.69065654688, 62025.68987155081, 62156.37843621551, 9219.262459003263, 9246.352755307063, 9497.720547068653, 9566.521673916277, 9982.600695972225, 17262.913685431493, 17275.481735547954, 17302.0, 17415.47753567395, 17443.21505532254, 6320.968395158086, 6384.744610215632, 6438.54930154894, 6512.120863683437, 6769.323067693192, 3390.9491357629654, 3393.5588373511778, 3460.7058400035776, 3488.389531831919, 3546.556680414948, 2728.5088684037064, 2801.551751719715, 2803.1730639461407, 2810.634617499753, 2813.5779633054794, 480.4090968109245, 491.65584091135634, 495.15823100728903, 527.5621234375536, 559.2589818490517, 443.4169067675996, 491.54286513542746, 492.59361027152744, 504.05992823384855, 512.4849526226119, 7228.602426866572, 7498.4376171787335, 7548.433867459853, 7652.273034061755, 7808.141104478503, 419.2662840029948, 472.1713392995271, 485.70614778059473, 489.80652642206843, 497.7685376300038, 3503.6146023937345, 3521.3661540922367, 3532.8056956867104, 3675.2833197526224, 3697.796621185807, 58151.0, 94247.52876235712, 98038.0, 111171.0, 111261.0, 84984.00319935914, 86872.56563717268, 87719.0, 88022.0, 89310.55344723235, 82630.58684706538, 83242.0, 84024.0, 84248.57875710582, 84920.72618910721, 6764.526483146133, 6833.111695479556, 6863.4726780992105, 7057.50597458173, 7081.8937715935335, 48847.755761220964, 49331.50668493269, 49743.50256497534, 50678.2398264019, 51481.0, 60151.69924150351, 68959.65520172367, 69585.0, 69739.74944760479, 73109.0, 8436.704715334934, 8665.133486651537, 8798.0, 8928.285737141143, 8977.730668079968, 9952.751181220527, 9952.850707239542, 9980.700578982642, 10047.0, 10274.33216840903, 9170.633174672937, 9429.0, 9510.619575216913, 9612.51937403113, 9990.100890919852, 9423.38747981379, 9559.665411710557, 9590.328676992543, 9737.0, 9917.553710082919, 9127.132922372364, 9264.814703705753, 9393.81212375735, 9518.381305215138, 9806.362586431858, 7981.414097288094, 8219.219174178443, 8297.10558014795, 8315.750527484186, 8354.45696029756, 8064.758057258292, 8079.555624440713, 8245.505269683837, 8480.74557763268, 8527.232549070613], "value": 6096.172606832131, "unit": "score"}], "name": "dromaeo_css", "value": 6244.266639274263, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 116.0, 116.0, 115.0, 117.0, 115.0, 115.0, 114.0, 116.0, 116.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 126.0, 125.0, 186.0, 124.0, 131.0, 130.0, 124.0, 158.0, 129.0], "value": 138.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 161.0, 162.0, 160.0, 163.0, 162.0, 162.0, 163.0, 162.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 126.0, 77.0, 76.0, 76.0, 76.0, 111.0, 79.0], "value": 84.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 115.0, 84.0, 85.0, 83.0, 106.0, 84.0, 83.0, 114.0], "value": 92.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 63.0, 64.0, 63.0, 65.0, 64.0, 65.0, 65.0, 65.0], "value": 64.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 68.0, 66.0, 67.0, 68.0, 67.0, 67.0, 67.0], "value": 67.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 89.0, 83.0, 86.0, 87.0, 83.0, 82.0, 82.0, 84.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 134.0, 136.0, 132.0, 129.0, 135.0, 147.0, 142.0, 186.0, 142.0], "value": 142.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 170.0, 177.0, 176.0, 171.0, 172.0, 174.0, 175.0, 173.0, 177.0], "value": 174.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 70.0, 70.0, 68.0, 68.0, 73.0, 68.0, 69.0, 73.0], "value": 69.8, "unit": "score"}], "name": "kraken", "value": 1554.0, "alertThreshold": 2.0}]} 20:48:47 INFO - Return code: 0 20:48:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:48:47 INFO - # TBPL SUCCESS # 20:48:47 INFO - Running post-action listener: _resource_record_post_action 20:48:47 INFO - [mozharness: 2016-09-21 03:48:47.696258Z] Finished run-tests step (success) 20:48:47 INFO - Running post-run listener: _resource_record_post_run 20:48:47 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 394657792; Read time: 8; Write time: 260064 20:48:47 INFO - TinderboxPrint: CPU usage
13.1% 20:48:47 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 20:48:47 INFO - TinderboxPrint: I/O write bytes / time
394,657,792 / 260,064 20:48:47 INFO - TinderboxPrint: CPU idle
8,343.6 (86.9%) 20:48:47 INFO - TinderboxPrint: CPU user
1,202.8 (12.5%) 20:48:47 INFO - TinderboxPrint: Swap in / out
0 / 0 20:48:47 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99647488; Read time: 0; Write time: 82204 20:48:47 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 295010304; Read time: 0; Write time: 177860 20:48:48 INFO - Running post-run listener: _upload_blobber_files 20:48:48 INFO - Blob upload gear active. 20:48:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:48:48 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 20:48:48 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'] 20:48:48 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 20:48:48 INFO - (blobuploader) - INFO - Open directory for files ... 20:48:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:48:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:48:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:48:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:48:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:48:52 INFO - (blobuploader) - INFO - Done attempting. 20:48:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:48:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:48:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:48:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:48:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:48:53 INFO - (blobuploader) - INFO - Done attempting. 20:48:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:48:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:48:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:48:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:48:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:48:54 INFO - (blobuploader) - INFO - Done attempting. 20:48:54 INFO - (blobuploader) - INFO - Iteration through files over. 20:48:54 INFO - Return code: 0 20:48:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:48:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:48:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/56fc725de9fc047b9761043ec0e8c7ba052fb6708184bb4eec39e03c8cd13e7fd3e660b5e23387443e8700bb2aceca4532281f832c540e4105070696547f3ca1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dc48c5dd017f5805a0f196a89d8f1088e11b6c1854c81e6f0abd71022e9821a185940de9609e13dde04b0f98c987aff917d9f6c1b79494185f7166ef698eb3b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/32ef20208ee696a64af218ef14686bf7e9370c5df041078db447b7ef5cc9f216fde2735651e85476a0903882c0e307e6193c5d752af858607be94fdcd8c9f885"} 20:48:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:48:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:48:54 INFO - Contents: 20:48:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/56fc725de9fc047b9761043ec0e8c7ba052fb6708184bb4eec39e03c8cd13e7fd3e660b5e23387443e8700bb2aceca4532281f832c540e4105070696547f3ca1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dc48c5dd017f5805a0f196a89d8f1088e11b6c1854c81e6f0abd71022e9821a185940de9609e13dde04b0f98c987aff917d9f6c1b79494185f7166ef698eb3b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/32ef20208ee696a64af218ef14686bf7e9370c5df041078db447b7ef5cc9f216fde2735651e85476a0903882c0e307e6193c5d752af858607be94fdcd8c9f885"} 20:48:54 INFO - Running post-run listener: copy_logs_to_upload_dir 20:48:54 INFO - Copying logs to upload dir... 20:48:54 INFO - mkdir: /builds/slave/test/build/upload/logs 20:48:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.345263 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-09-20 20:48:54.342125) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-20 20:48:54.346118) ========= 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=d2a8c569965ab8367867b893000001a1-1474428486.435408-1588921463 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/56fc725de9fc047b9761043ec0e8c7ba052fb6708184bb4eec39e03c8cd13e7fd3e660b5e23387443e8700bb2aceca4532281f832c540e4105070696547f3ca1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dc48c5dd017f5805a0f196a89d8f1088e11b6c1854c81e6f0abd71022e9821a185940de9609e13dde04b0f98c987aff917d9f6c1b79494185f7166ef698eb3b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/32ef20208ee696a64af218ef14686bf7e9370c5df041078db447b7ef5cc9f216fde2735651e85476a0903882c0e307e6193c5d752af858607be94fdcd8c9f885"} build_url:https://queue.taskcluster.net/v1/task/HUbAgtE-T6ilh0vonUHStg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011228 build_url: 'https://queue.taskcluster.net/v1/task/HUbAgtE-T6ilh0vonUHStg/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/56fc725de9fc047b9761043ec0e8c7ba052fb6708184bb4eec39e03c8cd13e7fd3e660b5e23387443e8700bb2aceca4532281f832c540e4105070696547f3ca1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dc48c5dd017f5805a0f196a89d8f1088e11b6c1854c81e6f0abd71022e9821a185940de9609e13dde04b0f98c987aff917d9f6c1b79494185f7166ef698eb3b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/32ef20208ee696a64af218ef14686bf7e9370c5df041078db447b7ef5cc9f216fde2735651e85476a0903882c0e307e6193c5d752af858607be94fdcd8c9f885"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-20 20:48:54.372094) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 20:48:54.372461) ========= 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=d2a8c569965ab8367867b893000001a1-1474428486.435408-1588921463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 20:48:54.456441) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-20 20:48:54.456814) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-20 20:48:54.457406) ========= ========= Total master_lag: 0.17 =========