builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-054 starttime: 1474176129.29 results: success (0) buildid: 20160917215217 builduid: 3529382297674a74821facfa0d511d9a revision: 639635348b41780875198e5f702d5714078deeee ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-17 22:22:09.286669) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-17 22:22:09.287063) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-17 22:22:09.287348) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-17 22:22:09.301878) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 22:22:09.302147) ========= 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=cbe409c6de289db6ac707de3000001d4-1474166449.127614-1672681899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-17 22:22:10-- 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% 37.4K=0.3s 2016-09-17 22:22:10 (37.4 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.451777 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 22:22:09.768120) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 22:22:09.768444) ========= 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=cbe409c6de289db6ac707de3000001d4-1474166449.127614-1672681899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019344 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 22:22:09.817515) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 22:22:09.817987) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 639635348b41780875198e5f702d5714078deeee --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 639635348b41780875198e5f702d5714078deeee --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=cbe409c6de289db6ac707de3000001d4-1474166449.127614-1672681899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-17 22:22:10,788 truncating revision to first 12 chars 2016-09-17 22:22:10,788 Setting DEBUG logging. 2016-09-17 22:22:10,788 attempt 1/10 2016-09-17 22:22:10,788 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/639635348b41?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-17 22:22:11,238 unpacking tar archive at: fx-team-639635348b41/testing/mozharness/ program finished with exit code 0 elapsedTime=0.770165 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 22:22:10.601602) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-17 22:22:10.601919) ========= script_repo_revision: 639635348b41780875198e5f702d5714078deeee ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-17 22:22:10.602426) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-17 22:22:10.602736) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-17 22:22:10.613329) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-09-17 22:22:10.613599) ========= /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=cbe409c6de289db6ac707de3000001d4-1474166449.127614-1672681899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:22:11 INFO - MultiFileLogger online at 20160917 22:22:11 in /builds/slave/test 22:22:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 22:22:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:22:11 INFO - {'append_to_log': False, 22:22:11 INFO - 'base_work_dir': '/builds/slave/test', 22:22:11 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:22:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:22:11 INFO - 'branch': 'Fx-Team-Non-PGO', 22:22:11 INFO - 'buildbot_json_path': 'buildprops.json', 22:22:11 INFO - 'config_files': ('talos/linux_config.py',), 22:22:11 INFO - 'default_actions': ('clobber', 22:22:11 INFO - 'read-buildbot-config', 22:22:11 INFO - 'download-and-extract', 22:22:11 INFO - 'populate-webroot', 22:22:11 INFO - 'create-virtualenv', 22:22:11 INFO - 'install', 22:22:11 INFO - 'run-tests'), 22:22:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:22:11 INFO - 'download_minidump_stackwalk': True, 22:22:11 INFO - 'download_symbols': 'ondemand', 22:22:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:22:11 INFO - 'tooltool.py': '/tools/tooltool.py', 22:22:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:22:11 INFO - '/tools/misc-python/virtualenv.py')}, 22:22:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:22:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:22:11 INFO - 'installer_path': 'installer.exe', 22:22:11 INFO - 'log_level': 'info', 22:22:11 INFO - 'log_name': 'talos', 22:22:11 INFO - 'log_to_console': True, 22:22:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:22:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:22:11 INFO - 'opt_config_files': (), 22:22:11 INFO - 'pip_index': False, 22:22:11 INFO - 'sps_profile': False, 22:22:11 INFO - 'sps_profile_interval': 0, 22:22:11 INFO - 'suite': 'dromaeojs', 22:22:11 INFO - 'system_bits': '32', 22:22:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:22:11 INFO - 'title': 'talos-linux64-ix-054', 22:22:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:22:11 INFO - 'use_talos_json': True, 22:22:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:22:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:22:11 INFO - 'work_dir': 'build'} 22:22:11 INFO - [mozharness: 2016-09-18 05:22:11.678918Z] Running clobber step. 22:22:11 INFO - Running pre-action listener: _resource_record_pre_action 22:22:11 INFO - Running main action method: clobber 22:22:11 INFO - rmtree: /builds/slave/test/build 22:22:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:22:12 INFO - Running post-action listener: _resource_record_post_action 22:22:12 INFO - [mozharness: 2016-09-18 05:22:12.141878Z] Finished clobber step (success) 22:22:12 INFO - [mozharness: 2016-09-18 05:22:12.141978Z] Running read-buildbot-config step. 22:22:12 INFO - Running pre-action listener: _resource_record_pre_action 22:22:12 INFO - Running main action method: read_buildbot_config 22:22:12 INFO - Using buildbot properties: 22:22:12 INFO - { 22:22:12 INFO - "project": "", 22:22:12 INFO - "product": "firefox", 22:22:12 INFO - "script_repo_revision": "production", 22:22:12 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:22:12 INFO - "repository": "", 22:22:12 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 22:22:12 INFO - "buildid": "20160917215217", 22:22:12 INFO - "pgo_build": "False", 22:22:12 INFO - "basedir": "/builds/slave/test", 22:22:12 INFO - "buildnumber": 3327, 22:22:12 INFO - "slavename": "talos-linux64-ix-054", 22:22:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:22:12 INFO - "platform": "ubuntu64_hw", 22:22:12 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:22:12 INFO - "branch": "fx-team", 22:22:12 INFO - "repo_path": "integration/fx-team", 22:22:12 INFO - "revision": "639635348b41780875198e5f702d5714078deeee", 22:22:12 INFO - "stage_platform": "linux64", 22:22:12 INFO - "builduid": "3529382297674a74821facfa0d511d9a", 22:22:12 INFO - "slavebuilddir": "test" 22:22:12 INFO - } 22:22:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/Mut_I0gdQL-ddjjWnD5Hjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 22:22:12 INFO - Running post-action listener: _resource_record_post_action 22:22:12 INFO - [mozharness: 2016-09-18 05:22:12.144402Z] Finished read-buildbot-config step (success) 22:22:12 INFO - [mozharness: 2016-09-18 05:22:12.144492Z] Running download-and-extract step. 22:22:12 INFO - Running pre-action listener: _resource_record_pre_action 22:22:12 INFO - Running main action method: download_and_extract 22:22:12 INFO - mkdir: /builds/slave/test/build/tests 22:22:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:12 INFO - trying https://queue.taskcluster.net/v1/task/Mut_I0gdQL-ddjjWnD5Hjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 22:22:12 INFO - Downloading https://queue.taskcluster.net/v1/task/Mut_I0gdQL-ddjjWnD5Hjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 22:22:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Mut_I0gdQL-ddjjWnD5Hjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:22:12 INFO - Downloaded 1361 bytes. 22:22:12 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 22:22:12 INFO - Using the following test package requirements: 22:22:12 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 22:22:12 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:22:12 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:22:12 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:12 INFO - u'jsshell-linux-x86_64.zip'], 22:22:12 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:22:12 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 22:22:12 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:22:12 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:22:12 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:22:12 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:22:12 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:22:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Mut_I0gdQL-ddjjWnD5Hjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 22:22:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Mut_I0gdQL-ddjjWnD5Hjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:22:12 INFO - Fetch https://queue.taskcluster.net/v1/task/Mut_I0gdQL-ddjjWnD5Hjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:22:13 INFO - Expected file size: 20365610 22:22:18 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:22:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Mut_I0gdQL-ddjjWnD5Hjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 22:22:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Mut_I0gdQL-ddjjWnD5Hjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:22:18 INFO - Fetch https://queue.taskcluster.net/v1/task/Mut_I0gdQL-ddjjWnD5Hjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:22:18 INFO - Expected file size: 20365610 22:22:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Mut_I0gdQL-ddjjWnD5Hjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 22:22:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Mut_I0gdQL-ddjjWnD5Hjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:22:23 INFO - Fetch https://queue.taskcluster.net/v1/task/Mut_I0gdQL-ddjjWnD5Hjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip into memory 22:22:24 INFO - Expected file size: 14414048 22:22: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')]} 22:22:25 INFO - trying https://queue.taskcluster.net/v1/task/Mut_I0gdQL-ddjjWnD5Hjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 22:22:25 INFO - Downloading https://queue.taskcluster.net/v1/task/Mut_I0gdQL-ddjjWnD5Hjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 22:22:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Mut_I0gdQL-ddjjWnD5Hjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:22:27 INFO - Downloaded 55600152 bytes. 22:22:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Mut_I0gdQL-ddjjWnD5Hjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 22:22:27 INFO - mkdir: /builds/slave/test/properties 22:22:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:22:27 INFO - Writing to file /builds/slave/test/properties/build_url 22:22:27 INFO - Contents: 22:22:27 INFO - build_url:https://queue.taskcluster.net/v1/task/Mut_I0gdQL-ddjjWnD5Hjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 22:22:28 INFO - Running post-action listener: _resource_record_post_action 22:22:28 INFO - Running post-action listener: set_extra_try_arguments 22:22:28 INFO - [mozharness: 2016-09-18 05:22:28.613542Z] Finished download-and-extract step (success) 22:22:28 INFO - [mozharness: 2016-09-18 05:22:28.613770Z] Running populate-webroot step. 22:22:28 INFO - Running pre-action listener: _resource_record_pre_action 22:22:28 INFO - Running main action method: populate_webroot 22:22:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:22:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:22:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:22:28 INFO - '--tppagecycles', 22:22:28 INFO - '7'], 22:22:28 INFO - 'tests': ['tsvgm']}}, 22:22:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:22:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:22:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:22:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:22:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:22:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:22:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:28 INFO - 'talos_options': ['--disable-e10s'], 22:22:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:22:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:22:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:28 INFO - 'talos_options': ['--disable-e10s'], 22:22:28 INFO - 'tests': ['damp', 'tps']}, 22:22:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:28 INFO - 'tests': ['damp', 'tps']}, 22:22:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:22:28 INFO - 'tests': ['dromaeo_dom']}, 22:22:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:22:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:22:28 INFO - 'tests': ['basic_compositor_video']}, 22:22:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:22:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:22:28 INFO - 'tests': ['a11yr', 22:22:28 INFO - 'ts_paint', 22:22:28 INFO - 'tpaint', 22:22:28 INFO - 'sessionrestore', 22:22:28 INFO - 'sessionrestore_no_auto_restore', 22:22:28 INFO - 'tabpaint']}, 22:22:28 INFO - 'other-e10s': {'tests': ['a11yr', 22:22:28 INFO - 'ts_paint', 22:22:28 INFO - 'tpaint', 22:22:28 INFO - 'sessionrestore', 22:22:28 INFO - 'sessionrestore_no_auto_restore', 22:22:28 INFO - 'tabpaint']}, 22:22:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:22:28 INFO - 'ts_paint', 22:22:28 INFO - 'tpaint', 22:22:28 INFO - 'sessionrestore', 22:22:28 INFO - 'sessionrestore_no_auto_restore', 22:22:28 INFO - 'tabpaint']}, 22:22:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:22:28 INFO - 'ts_paint', 22:22:28 INFO - 'tpaint', 22:22:28 INFO - 'sessionrestore', 22:22:28 INFO - 'sessionrestore_no_auto_restore', 22:22:28 INFO - 'tabpaint']}, 22:22:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:22:28 INFO - 'tests': ['a11yr', 22:22:28 INFO - 'ts_paint', 22:22:28 INFO - 'tpaint', 22:22:28 INFO - 'sessionrestore', 22:22:28 INFO - 'sessionrestore_no_auto_restore', 22:22:28 INFO - 'tabpaint']}, 22:22:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:22:28 INFO - 'tests': ['a11yr', 22:22:28 INFO - 'ts_paint', 22:22:28 INFO - 'tpaint', 22:22:28 INFO - 'sessionrestore', 22:22:28 INFO - 'sessionrestore_no_auto_restore', 22:22:28 INFO - 'tabpaint']}, 22:22:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:22:28 INFO - 'tests': ['tsvgx', 22:22:28 INFO - 'tsvgr_opacity', 22:22:28 INFO - 'tart', 22:22:28 INFO - 'tscrollx', 22:22:28 INFO - 'cart']}, 22:22:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:22:28 INFO - 'tsvgr_opacity', 22:22:28 INFO - 'tart', 22:22:28 INFO - 'tscrollx', 22:22:28 INFO - 'cart']}, 22:22:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:28 INFO - 'talos_options': ['--disable-e10s'], 22:22:28 INFO - 'tests': ['tp5o']}, 22:22:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:28 INFO - 'tests': ['tp5o']}, 22:22:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:28 INFO - 'talos_options': ['--disable-e10s', 22:22:28 INFO - '--xperf_path', 22:22:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:22:28 INFO - 'tests': ['tp5n']}, 22:22:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:28 INFO - 'talos_options': ['--xperf_path', 22:22:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:22:28 INFO - 'tests': ['tp5n']}}, 22:22:28 INFO - 'talos.zip': {'path': '', 22:22:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:22:28 INFO - Running post-action listener: _resource_record_post_action 22:22:28 INFO - [mozharness: 2016-09-18 05:22:28.631691Z] Finished populate-webroot step (success) 22:22:28 INFO - [mozharness: 2016-09-18 05:22:28.631779Z] Running create-virtualenv step. 22:22:28 INFO - Running pre-action listener: _resource_record_pre_action 22:22:28 INFO - Running main action method: create_virtualenv 22:22:28 INFO - Creating virtualenv /builds/slave/test/build/venv 22:22:28 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 22:22:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:22:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:22:28 INFO - Using real prefix '/usr' 22:22:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:22:29 INFO - Installing distribute.............................................................................................................................................................................................done. 22:22:31 INFO - Installing pip.................done. 22:22:31 INFO - Return code: 0 22:22:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86a804bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adbf60>, '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 0x2adcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2add1d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1474166449.127614-1672681899', '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 22:22:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:22:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:22:31 INFO - Using env: {'DISPLAY': ':0', 22:22:31 INFO - 'HOME': '/home/cltbld', 22:22:31 INFO - 'LANG': 'en_US.UTF-8', 22:22:31 INFO - 'LANGUAGE': 'en_US:en', 22:22:31 INFO - 'LOGNAME': 'cltbld', 22:22:31 INFO - 'MAIL': '/var/mail/cltbld', 22:22:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:31 INFO - 'MOZ_NO_REMOTE': '1', 22:22:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:31 INFO - 'NO_EM_RESTART': '1', 22:22:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:31 INFO - 'PWD': '/builds/slave/test', 22:22:31 INFO - 'SHELL': '/bin/bash', 22:22:31 INFO - 'SHLVL': '1', 22:22:31 INFO - 'TERM': 'linux', 22:22:31 INFO - 'TMOUT': '86400', 22:22:31 INFO - 'USER': 'cltbld', 22:22:31 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1474166449.127614-1672681899', 22:22:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:31 INFO - '_': '/tools/buildbot/bin/python'} 22:22:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:22:31 INFO - Cleaning up... 22:22:31 INFO - Return code: 0 22:22:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86a804bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adbf60>, '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 0x2adcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2add1d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1474166449.127614-1672681899', '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 22:22:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:22:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:22:31 INFO - Using env: {'DISPLAY': ':0', 22:22:31 INFO - 'HOME': '/home/cltbld', 22:22:31 INFO - 'LANG': 'en_US.UTF-8', 22:22:31 INFO - 'LANGUAGE': 'en_US:en', 22:22:31 INFO - 'LOGNAME': 'cltbld', 22:22:31 INFO - 'MAIL': '/var/mail/cltbld', 22:22:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:31 INFO - 'MOZ_NO_REMOTE': '1', 22:22:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:31 INFO - 'NO_EM_RESTART': '1', 22:22:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:31 INFO - 'PWD': '/builds/slave/test', 22:22:31 INFO - 'SHELL': '/bin/bash', 22:22:31 INFO - 'SHLVL': '1', 22:22:31 INFO - 'TERM': 'linux', 22:22:31 INFO - 'TMOUT': '86400', 22:22:31 INFO - 'USER': 'cltbld', 22:22:31 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1474166449.127614-1672681899', 22:22:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:31 INFO - '_': '/tools/buildbot/bin/python'} 22:22:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:31 INFO - Downloading/unpacking psutil>=3.1.1 22:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:22:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:22:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:22:33 INFO - Installing collected packages: psutil 22:22:33 INFO - Running setup.py install for psutil 22:22:33 INFO - building 'psutil._psutil_linux' extension 22:22:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:22:34 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 22:22:34 INFO - building 'psutil._psutil_posix' extension 22:22:34 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 22:22:34 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 22:22:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:22:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:22:34 INFO - Successfully installed psutil 22:22:34 INFO - Cleaning up... 22:22:34 INFO - Return code: 0 22:22:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86a804bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adbf60>, '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 0x2adcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2add1d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1474166449.127614-1672681899', '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 22:22:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:22:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:22:34 INFO - Using env: {'DISPLAY': ':0', 22:22:34 INFO - 'HOME': '/home/cltbld', 22:22:34 INFO - 'LANG': 'en_US.UTF-8', 22:22:34 INFO - 'LANGUAGE': 'en_US:en', 22:22:34 INFO - 'LOGNAME': 'cltbld', 22:22:34 INFO - 'MAIL': '/var/mail/cltbld', 22:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:34 INFO - 'MOZ_NO_REMOTE': '1', 22:22:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:34 INFO - 'NO_EM_RESTART': '1', 22:22:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:34 INFO - 'PWD': '/builds/slave/test', 22:22:34 INFO - 'SHELL': '/bin/bash', 22:22:34 INFO - 'SHLVL': '1', 22:22:34 INFO - 'TERM': 'linux', 22:22:34 INFO - 'TMOUT': '86400', 22:22:34 INFO - 'USER': 'cltbld', 22:22:34 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1474166449.127614-1672681899', 22:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:34 INFO - '_': '/tools/buildbot/bin/python'} 22:22:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:22:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:22:36 INFO - Installing collected packages: mozsystemmonitor 22:22:36 INFO - Running setup.py install for mozsystemmonitor 22:22:36 INFO - Successfully installed mozsystemmonitor 22:22:36 INFO - Cleaning up... 22:22:36 INFO - Return code: 0 22:22:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:22: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')]} 22:22:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22: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')]} 22:22:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86a804bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adbf60>, '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 0x2adcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2add1d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1474166449.127614-1672681899', '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 22:22:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 22:22:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 22:22:36 INFO - Using env: {'DISPLAY': ':0', 22:22:36 INFO - 'HOME': '/home/cltbld', 22:22:36 INFO - 'LANG': 'en_US.UTF-8', 22:22:36 INFO - 'LANGUAGE': 'en_US:en', 22:22:36 INFO - 'LOGNAME': 'cltbld', 22:22:36 INFO - 'MAIL': '/var/mail/cltbld', 22:22:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:36 INFO - 'MOZ_NO_REMOTE': '1', 22:22:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:36 INFO - 'NO_EM_RESTART': '1', 22:22:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:36 INFO - 'PWD': '/builds/slave/test', 22:22:36 INFO - 'SHELL': '/bin/bash', 22:22:36 INFO - 'SHLVL': '1', 22:22:36 INFO - 'TERM': 'linux', 22:22:36 INFO - 'TMOUT': '86400', 22:22:36 INFO - 'USER': 'cltbld', 22:22:36 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1474166449.127614-1672681899', 22:22:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:36 INFO - '_': '/tools/buildbot/bin/python'} 22:22:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:36 INFO - Downloading/unpacking jsonschema==2.5.1 22:22: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 22:22: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 22:22: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 22:22: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 22:22: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 22:22: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 22:22:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:22:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:39 INFO - Downloading functools32-3.2.3-2.tar.gz 22:22:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:22:39 INFO - warning: no files found matching '*.txt' 22:22:39 INFO - no previously-included directories found matching 'build' 22:22:39 INFO - no previously-included directories found matching 'dist' 22:22:39 INFO - no previously-included directories found matching '.git*' 22:22:39 INFO - Installing collected packages: jsonschema, functools32 22:22:39 INFO - Running setup.py install for functools32 22:22:39 INFO - warning: no files found matching '*.txt' 22:22:39 INFO - no previously-included directories found matching 'build' 22:22:39 INFO - no previously-included directories found matching 'dist' 22:22:39 INFO - no previously-included directories found matching '.git*' 22:22:39 INFO - Successfully installed jsonschema functools32 22:22:39 INFO - Cleaning up... 22:22:39 INFO - Return code: 0 22:22:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:22:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86a804bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adbf60>, '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 0x2adcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2add1d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1474166449.127614-1672681899', '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 22:22:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:22:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 22:22:39 INFO - Using env: {'DISPLAY': ':0', 22:22:39 INFO - 'HOME': '/home/cltbld', 22:22:39 INFO - 'LANG': 'en_US.UTF-8', 22:22:39 INFO - 'LANGUAGE': 'en_US:en', 22:22:39 INFO - 'LOGNAME': 'cltbld', 22:22:39 INFO - 'MAIL': '/var/mail/cltbld', 22:22:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:39 INFO - 'MOZ_NO_REMOTE': '1', 22:22:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:39 INFO - 'NO_EM_RESTART': '1', 22:22:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:39 INFO - 'PWD': '/builds/slave/test', 22:22:39 INFO - 'SHELL': '/bin/bash', 22:22:39 INFO - 'SHLVL': '1', 22:22:39 INFO - 'TERM': 'linux', 22:22:39 INFO - 'TMOUT': '86400', 22:22:39 INFO - 'USER': 'cltbld', 22:22:39 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1474166449.127614-1672681899', 22:22:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:39 INFO - '_': '/tools/buildbot/bin/python'} 22:22:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:22:39 INFO - Cleaning up... 22:22:39 INFO - Return code: 0 22:22:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:22:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86a804bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adbf60>, '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 0x2adcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2add1d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1474166449.127614-1672681899', '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 22:22:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:22:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:22:39 INFO - Using env: {'DISPLAY': ':0', 22:22:39 INFO - 'HOME': '/home/cltbld', 22:22:39 INFO - 'LANG': 'en_US.UTF-8', 22:22:39 INFO - 'LANGUAGE': 'en_US:en', 22:22:39 INFO - 'LOGNAME': 'cltbld', 22:22:39 INFO - 'MAIL': '/var/mail/cltbld', 22:22:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:39 INFO - 'MOZ_NO_REMOTE': '1', 22:22:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:39 INFO - 'NO_EM_RESTART': '1', 22:22:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:39 INFO - 'PWD': '/builds/slave/test', 22:22:39 INFO - 'SHELL': '/bin/bash', 22:22:39 INFO - 'SHLVL': '1', 22:22:39 INFO - 'TERM': 'linux', 22:22:39 INFO - 'TMOUT': '86400', 22:22:39 INFO - 'USER': 'cltbld', 22:22:39 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1474166449.127614-1672681899', 22:22:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:39 INFO - '_': '/tools/buildbot/bin/python'} 22:22:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:39 INFO - Downloading/unpacking blobuploader==1.2.4 22:22:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:41 INFO - Downloading blobuploader-1.2.4.tar.gz 22:22:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:22:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:22: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 22:22: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 22:22: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 22:22: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 22:22: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 22:22: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 22:22:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:22:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:22:42 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 22:22:42 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 22:22:42 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 22:22:42 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 22:22:42 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 22:22:42 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 22:22:42 INFO - Downloading docopt-0.6.1.tar.gz 22:22:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:22:42 INFO - Installing collected packages: blobuploader, requests, docopt 22:22:42 INFO - Running setup.py install for blobuploader 22:22:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:22:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:22:42 INFO - Running setup.py install for requests 22:22:42 INFO - Running setup.py install for docopt 22:22:42 INFO - Successfully installed blobuploader requests docopt 22:22:42 INFO - Cleaning up... 22:22:42 INFO - Return code: 0 22:22:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86a804bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adbf60>, '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 0x2adcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2add1d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1474166449.127614-1672681899', '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 22:22:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:22:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:22:42 INFO - Using env: {'DISPLAY': ':0', 22:22:42 INFO - 'HOME': '/home/cltbld', 22:22:42 INFO - 'LANG': 'en_US.UTF-8', 22:22:42 INFO - 'LANGUAGE': 'en_US:en', 22:22:42 INFO - 'LOGNAME': 'cltbld', 22:22:42 INFO - 'MAIL': '/var/mail/cltbld', 22:22:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:42 INFO - 'MOZ_NO_REMOTE': '1', 22:22:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:42 INFO - 'NO_EM_RESTART': '1', 22:22:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:42 INFO - 'PWD': '/builds/slave/test', 22:22:42 INFO - 'SHELL': '/bin/bash', 22:22:42 INFO - 'SHLVL': '1', 22:22:42 INFO - 'TERM': 'linux', 22:22:42 INFO - 'TMOUT': '86400', 22:22:42 INFO - 'USER': 'cltbld', 22:22:42 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1474166449.127614-1672681899', 22:22:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:42 INFO - '_': '/tools/buildbot/bin/python'} 22:22:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:22:43 INFO - Running setup.py (path:/tmp/pip-hUqdhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:22:43 INFO - Running setup.py (path:/tmp/pip-k7K7SP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:22:43 INFO - Running setup.py (path:/tmp/pip-4Q0DCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:22:43 INFO - Running setup.py (path:/tmp/pip-F5YMgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:22:43 INFO - Running setup.py (path:/tmp/pip-R0Qv4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:22:43 INFO - Running setup.py (path:/tmp/pip-rR6Oml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:22:43 INFO - Running setup.py (path:/tmp/pip-pWxBI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:22:43 INFO - Running setup.py (path:/tmp/pip-KdRzbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:22:43 INFO - Running setup.py (path:/tmp/pip-Prvr4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:22:43 INFO - Running setup.py (path:/tmp/pip-Opr5Jz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:22:43 INFO - Running setup.py (path:/tmp/pip-NQI98D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:22:43 INFO - Running setup.py (path:/tmp/pip-oF0PQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:22:44 INFO - Running setup.py (path:/tmp/pip-c0EIZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:22:44 INFO - Running setup.py (path:/tmp/pip-8RL9i_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:22:44 INFO - Running setup.py (path:/tmp/pip-5Iryfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:22:44 INFO - Running setup.py (path:/tmp/pip-hwbRh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:22:44 INFO - Running setup.py (path:/tmp/pip-zR6Bgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:22:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:22:44 INFO - Running setup.py install for manifestparser 22:22:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:22:44 INFO - Running setup.py install for mozcrash 22:22:44 INFO - Running setup.py install for mozdebug 22:22:44 INFO - Running setup.py install for mozdevice 22:22:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:22:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:22:44 INFO - Running setup.py install for mozfile 22:22:44 INFO - Running setup.py install for mozhttpd 22:22:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:22:45 INFO - Running setup.py install for mozinfo 22:22:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:22:45 INFO - Running setup.py install for mozInstall 22:22:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:22:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:22:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:22:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:22:45 INFO - Running setup.py install for mozleak 22:22:45 INFO - Running setup.py install for mozlog 22:22:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:22:45 INFO - Running setup.py install for moznetwork 22:22:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:22:45 INFO - Running setup.py install for mozprocess 22:22:45 INFO - Running setup.py install for mozprofile 22:22:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:22:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:22:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:22:45 INFO - Running setup.py install for mozrunner 22:22:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:22:45 INFO - Running setup.py install for mozscreenshot 22:22:45 INFO - Running setup.py install for moztest 22:22:46 INFO - Running setup.py install for mozversion 22:22:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:22:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:22:46 INFO - Cleaning up... 22:22:46 INFO - Return code: 0 22:22:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86a804bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adbf60>, '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 0x2adcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2add1d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1474166449.127614-1672681899', '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 22:22:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:22:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:22:46 INFO - Using env: {'DISPLAY': ':0', 22:22:46 INFO - 'HOME': '/home/cltbld', 22:22:46 INFO - 'LANG': 'en_US.UTF-8', 22:22:46 INFO - 'LANGUAGE': 'en_US:en', 22:22:46 INFO - 'LOGNAME': 'cltbld', 22:22:46 INFO - 'MAIL': '/var/mail/cltbld', 22:22:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:46 INFO - 'MOZ_NO_REMOTE': '1', 22:22:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:46 INFO - 'NO_EM_RESTART': '1', 22:22:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:46 INFO - 'PWD': '/builds/slave/test', 22:22:46 INFO - 'SHELL': '/bin/bash', 22:22:46 INFO - 'SHLVL': '1', 22:22:46 INFO - 'TERM': 'linux', 22:22:46 INFO - 'TMOUT': '86400', 22:22:46 INFO - 'USER': 'cltbld', 22:22:46 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1474166449.127614-1672681899', 22:22:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:46 INFO - '_': '/tools/buildbot/bin/python'} 22:22:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:22:46 INFO - Running setup.py (path:/tmp/pip-_GDe9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:22:46 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 22:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:22:46 INFO - Running setup.py (path:/tmp/pip-7tdPXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:22:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:22:46 INFO - Running setup.py (path:/tmp/pip-ee0qIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:22:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:22:46 INFO - Running setup.py (path:/tmp/pip-W6eCdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:22:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:22:46 INFO - Running setup.py (path:/tmp/pip-oU1P85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:22:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 22:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:22:46 INFO - Running setup.py (path:/tmp/pip-bTwuA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:22:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 22:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:22:46 INFO - Running setup.py (path:/tmp/pip-rdFGcW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:22:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 22:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:22:46 INFO - Running setup.py (path:/tmp/pip-TK58bY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:22:47 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)) 22:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:22:47 INFO - Running setup.py (path:/tmp/pip-7Y8XFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:22:47 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)) 22:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:22:47 INFO - Running setup.py (path:/tmp/pip-TmGuLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:22:47 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)) 22:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:22:47 INFO - Running setup.py (path:/tmp/pip-CnJ2Zg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:22:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 22:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:22:47 INFO - Running setup.py (path:/tmp/pip-0Dh4lT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:22:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 22:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:22:47 INFO - Running setup.py (path:/tmp/pip-ldXwy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:22:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 22:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:22:47 INFO - Running setup.py (path:/tmp/pip-CdtGlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:22:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:22:47 INFO - Running setup.py (path:/tmp/pip-uuYLO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:22:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 22:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:22:47 INFO - Running setup.py (path:/tmp/pip-67wn2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:22:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:22:47 INFO - Running setup.py (path:/tmp/pip-vCQa8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:22:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 22:22:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:22:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:22:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:22:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:22:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:22:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:49 INFO - Downloading blessings-1.6.tar.gz 22:22:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:22:49 INFO - Installing collected packages: blessings 22:22:49 INFO - Running setup.py install for blessings 22:22:49 INFO - Successfully installed blessings 22:22:49 INFO - Cleaning up... 22:22:49 INFO - Return code: 0 22:22:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:22:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:22:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:22:50 INFO - Reading from file tmpfile_stdout 22:22:50 INFO - Current package versions: 22:22:50 INFO - argparse == 1.2.1 22:22:50 INFO - blessings == 1.6 22:22:50 INFO - blobuploader == 1.2.4 22:22:50 INFO - docopt == 0.6.1 22:22:50 INFO - functools32 == 3.2.3-2 22:22:50 INFO - jsonschema == 2.5.1 22:22:50 INFO - manifestparser == 1.1 22:22:50 INFO - mozInstall == 1.12 22:22:50 INFO - mozcrash == 0.17 22:22:50 INFO - mozdebug == 0.1 22:22:50 INFO - mozdevice == 0.48 22:22:50 INFO - mozfile == 1.2 22:22:50 INFO - mozhttpd == 0.7 22:22:50 INFO - mozinfo == 0.9 22:22:50 INFO - mozleak == 0.1 22:22:50 INFO - mozlog == 3.4 22:22:50 INFO - moznetwork == 0.27 22:22:50 INFO - mozprocess == 0.23 22:22:50 INFO - mozprofile == 0.28 22:22:50 INFO - mozrunner == 6.12 22:22:50 INFO - mozscreenshot == 0.1 22:22:50 INFO - mozsystemmonitor == 0.3 22:22:50 INFO - moztest == 0.7 22:22:50 INFO - mozversion == 1.4 22:22:50 INFO - psutil == 3.1.1 22:22:50 INFO - requests == 1.2.3 22:22:50 INFO - wsgiref == 0.1.2 22:22:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:50 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 0x7f86a804bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adbf60>, '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 0x2adcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2add1d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1474166449.127614-1672681899', '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 22:22:50 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 22:22:50 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 22:22:50 INFO - Using env: {'DISPLAY': ':0', 22:22:50 INFO - 'HOME': '/home/cltbld', 22:22:50 INFO - 'LANG': 'en_US.UTF-8', 22:22:50 INFO - 'LANGUAGE': 'en_US:en', 22:22:50 INFO - 'LOGNAME': 'cltbld', 22:22:50 INFO - 'MAIL': '/var/mail/cltbld', 22:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:50 INFO - 'MOZ_NO_REMOTE': '1', 22:22:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:50 INFO - 'NO_EM_RESTART': '1', 22:22:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:50 INFO - 'PWD': '/builds/slave/test', 22:22:50 INFO - 'SHELL': '/bin/bash', 22:22:50 INFO - 'SHLVL': '1', 22:22:50 INFO - 'TERM': 'linux', 22:22:50 INFO - 'TMOUT': '86400', 22:22:50 INFO - 'USER': 'cltbld', 22:22:50 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1474166449.127614-1672681899', 22:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:50 INFO - '_': '/tools/buildbot/bin/python'} 22:22:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:22:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 22:22:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 22:22:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:22:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 22:22:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 22:22:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 22:22:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 22:22:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 22:22:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:22:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:22:50 INFO - Cleaning up... 22:22:50 INFO - Return code: 0 22:22:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86a804bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adbf60>, '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 0x2adcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2add1d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1474166449.127614-1672681899', '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 22:22:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:22:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:22:50 INFO - Using env: {'DISPLAY': ':0', 22:22:50 INFO - 'HOME': '/home/cltbld', 22:22:50 INFO - 'LANG': 'en_US.UTF-8', 22:22:50 INFO - 'LANGUAGE': 'en_US:en', 22:22:50 INFO - 'LOGNAME': 'cltbld', 22:22:50 INFO - 'MAIL': '/var/mail/cltbld', 22:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:50 INFO - 'MOZ_NO_REMOTE': '1', 22:22:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:50 INFO - 'NO_EM_RESTART': '1', 22:22:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:50 INFO - 'PWD': '/builds/slave/test', 22:22:50 INFO - 'SHELL': '/bin/bash', 22:22:50 INFO - 'SHLVL': '1', 22:22:50 INFO - 'TERM': 'linux', 22:22:50 INFO - 'TMOUT': '86400', 22:22:50 INFO - 'USER': 'cltbld', 22:22:50 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1474166449.127614-1672681899', 22:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:50 INFO - '_': '/tools/buildbot/bin/python'} 22:22:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:22:50 INFO - Cleaning up... 22:22:50 INFO - Return code: 0 22:22:50 INFO - Running post-action listener: _resource_record_post_action 22:22:50 INFO - Running post-action listener: _start_resource_monitoring 22:22:50 INFO - Starting resource monitoring. 22:22:50 INFO - [mozharness: 2016-09-18 05:22:50.537730Z] Finished create-virtualenv step (success) 22:22:50 INFO - [mozharness: 2016-09-18 05:22:50.538237Z] Running install step. 22:22:50 INFO - Running pre-action listener: _resource_record_pre_action 22:22:50 INFO - Running main action method: install 22:22:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:22:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:22:50 INFO - Reading from file tmpfile_stdout 22:22:50 INFO - Detecting whether we're running mozinstall >=1.0... 22:22:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:22:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:22:50 INFO - Reading from file tmpfile_stdout 22:22:50 INFO - Output received: 22:22:50 INFO - Usage: mozinstall [options] installer 22:22:50 INFO - Options: 22:22:50 INFO - -h, --help show this help message and exit 22:22:50 INFO - -d DEST, --destination=DEST 22:22:50 INFO - Directory to install application into. [default: 22:22:50 INFO - "/builds/slave/test"] 22:22:50 INFO - --app=APP Application being installed. [default: firefox] 22:22:50 INFO - mkdir: /builds/slave/test/build/application 22:22:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:22:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:23:06 INFO - Reading from file tmpfile_stdout 22:23:06 INFO - Output received: 22:23:06 INFO - /builds/slave/test/build/application/firefox/firefox 22:23:06 INFO - Running post-action listener: _resource_record_post_action 22:23:06 INFO - [mozharness: 2016-09-18 05:23:06.891449Z] Finished install step (success) 22:23:06 INFO - [mozharness: 2016-09-18 05:23:06.891776Z] Running run-tests step. 22:23:06 INFO - Running pre-action listener: _resource_record_pre_action 22:23:06 INFO - Running main action method: run_tests 22:23:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:23:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:23:06 INFO - Python 2.7.3 22:23:06 INFO - Return code: 0 22:23:06 INFO - grabbing minidump binary from tooltool 22:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:23:06 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adbf60>, '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 0x2adcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2add1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:23:06 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:23:06 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:23:06 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 22:23:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:23:06 INFO - Return code: 0 22:23:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:23:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:23:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:23:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:23:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:23:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Mut_I0gdQL-ddjjWnD5Hjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 22:23:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Mut_I0gdQL-ddjjWnD5Hjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 22:23:06 INFO - Using env: {'DISPLAY': ':0', 22:23:06 INFO - 'HOME': '/home/cltbld', 22:23:06 INFO - 'LANG': 'en_US.UTF-8', 22:23:06 INFO - 'LANGUAGE': 'en_US:en', 22:23:06 INFO - 'LOGNAME': 'cltbld', 22:23:06 INFO - 'MAIL': '/var/mail/cltbld', 22:23:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:23:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:23:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:06 INFO - 'MOZ_NO_REMOTE': '1', 22:23:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:23:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:23:06 INFO - 'NO_EM_RESTART': '1', 22:23:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:23:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:06 INFO - 'PWD': '/builds/slave/test', 22:23:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:23:06 INFO - 'SHELL': '/bin/bash', 22:23:06 INFO - 'SHLVL': '1', 22:23:06 INFO - 'TERM': 'linux', 22:23:06 INFO - 'TMOUT': '86400', 22:23:06 INFO - 'USER': 'cltbld', 22:23:06 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1474166449.127614-1672681899', 22:23:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:06 INFO - '_': '/tools/buildbot/bin/python'} 22:23:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Mut_I0gdQL-ddjjWnD5Hjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 22:23:07 INFO - mozversion application_buildid: 20160917215217 22:23:07 INFO - mozversion application_changeset: 639635348b41780875198e5f702d5714078deeee 22:23:07 INFO - mozversion application_display_name: Nightly 22:23:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:23:07 INFO - mozversion application_name: Firefox 22:23:07 INFO - mozversion application_remotingname: firefox 22:23:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:23:07 INFO - mozversion application_vendor: Mozilla 22:23:07 INFO - mozversion application_version: 51.0a1 22:23:07 INFO - mozversion platform_buildid: 20160917215217 22:23:07 INFO - mozversion platform_changeset: 639635348b41780875198e5f702d5714078deeee 22:23:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:23:07 INFO - mozversion platform_version: 51.0a1 22:23:07 INFO - using testdate: 1474176187 22:23:07 INFO - actual date: 1474176187 22:23:07 INFO - starting webserver on 'localhost:53192' 22:23:07 INFO - SUITE-START | Running 2 tests 22:23:07 INFO - TEST-START | dromaeo_css 22:23:07 INFO - operating with platform_type : linux_ 22:23:07 INFO - Initialising browser for dromaeo_css test... 22:23:07 INFO - TEST-INFO | started process 4589 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUVkvM7/profile http://localhost:53192/getInfo.html) 22:23:12 INFO - PROCESS | 4589 | __metrics Screen width/height:1600/1200 22:23:12 INFO - PROCESS | 4589 | colorDepth:24 22:23:12 INFO - PROCESS | 4589 | Browser inner width/height: 1024/697 22:23:12 INFO - PROCESS | 4589 | __metrics 22:23:12 INFO - PROCESS | 4589 | 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" 22:23:12 INFO - PROCESS | 4589 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:23:13 INFO - PROCESS | 4589 | console.error: PushService: 22:23:13 INFO - PROCESS | 4589 | stateChangeProcessEnqueue: Error transitioning state 22:23:13 INFO - PROCESS | 4589 | UnknownError 22:23:13 INFO - TEST-INFO | 4589: exit 0 22:23:13 INFO - Browser initialized. 22:23:13 INFO - Running cycle 1/1 for dromaeo_css test... 22:23:13 INFO - TEST-INFO | started process 4668 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUVkvM7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:23:26 INFO - PROCESS | 4668 | RSS: Main: 174428160 22:23:26 INFO - PROCESS | 4668 | 22:23:33 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 22:23:35 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 22:23:36 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 2.01676 seconds. 22:23:42 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.05006 seconds. 22:23:45 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 22:23:54 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.21669 seconds. 22:24:03 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 22:24:07 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 22:24:15 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 22:24:17 INFO - PROCESS | 4668 | 1474176257020 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] 22:24:33 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 22:24:51 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 22:24:54 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 22:25:04 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 22:25:08 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.03337 seconds. 22:25:14 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.05005 seconds. 22:25:17 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 22:25:27 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.10006 seconds. 22:25:30 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.03342 seconds. 22:25:32 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 22:25:33 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 22:25:34 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 2.00008 seconds. 22:25:35 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 22:25:44 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.05006 seconds. 22:25:53 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 22:26:01 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00303 seconds. 22:26:06 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.03337 seconds. 22:26:07 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 22:26:11 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 22:26:22 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 22:26:28 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 22:26:30 INFO - PROCESS | 4668 | Cycle 1(1): loaded http://localhost:53192/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53192/tests/dromaeo/cssquery-ext.html) 22:26:31 INFO - PROCESS | 4668 | RSS: Main: 272486400 22:26:31 INFO - PROCESS | 4668 | 22:26:37 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.06672 seconds. 22:26:56 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 22:27:02 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 22:27:04 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 22:27:33 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 22:27:39 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 22:27:45 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 22:27:47 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 22:27:49 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 22:27:51 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 22:28:11 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 22:28:19 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 22:28:23 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 22:28:25 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 22:28:27 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 22:28:29 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 22:28:31 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 22:28:34 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 22:28:37 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 22:28:38 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 2.00006 seconds. 22:28:39 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00008 seconds. 22:28:41 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 22:28:47 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 22:28:50 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 22:29:06 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 22:29:18 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 22:29:26 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 22:29:28 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 22:29:32 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 22:29:34 INFO - PROCESS | 4668 | Cycle 1(1): loaded http://localhost:53192/tests/dromaeo/cssquery-ext.html (next: http://localhost:53192/tests/dromaeo/cssquery-jquery.html) 22:29:35 INFO - PROCESS | 4668 | RSS: Main: 274726912 22:29:35 INFO - PROCESS | 4668 | 22:29:38 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.03339 seconds. 22:29:41 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.05001 seconds. 22:29:59 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00459 seconds. 22:30:22 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1 seconds. 22:30:30 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 22:30:44 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 22:30:52 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 22:31:02 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 22:31:04 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 22:31:08 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 22:31:14 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 22:31:19 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 22:31:20 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 22:31:24 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 22:31:29 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 22:31:35 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 22:31:47 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 22:31:55 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 22:31:57 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 22:32:09 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 22:32:11 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 22:32:15 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 22:32:17 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 22:32:19 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 22:32:37 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 22:32:37 INFO - PROCESS | 4668 | Cycle 1(1): loaded http://localhost:53192/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53192/tests/dromaeo/cssquery-mootools.html) 22:32:38 INFO - PROCESS | 4668 | RSS: Main: 219009024 22:32:38 INFO - PROCESS | 4668 | 22:32:55 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 22:32:56 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 22:33:12 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 22:33:16 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 22:33:25 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 22:33:33 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.03339 seconds. 22:33:42 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 22:33:55 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 22:34:03 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00296 seconds. 22:34:07 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 22:34:13 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 22:34:29 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 22:34:33 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 22:34:37 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 22:34:48 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 22:34:49 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 22:34:51 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 22:34:54 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 22:34:55 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 22:34:57 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 22:35:05 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 22:35:38 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.01674 seconds. 22:35:40 INFO - PROCESS | 4668 | Cycle 1(1): loaded http://localhost:53192/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53192/tests/dromaeo/cssquery-prototype.html) 22:35:40 INFO - PROCESS | 4668 | RSS: Main: 218054656 22:35:40 INFO - PROCESS | 4668 | 22:35:45 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 22:35:53 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 22:35:57 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 22:36:16 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 22:36:18 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.01668 seconds. 22:36:19 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 2.01673 seconds. 22:36:35 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 22:37:02 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 22:37:06 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 22:37:08 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 22:37:10 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 22:37:17 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.05008 seconds. 22:37:19 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.05008 seconds. 22:37:22 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.01674 seconds. 22:37:33 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 22:37:40 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1 seconds. 22:37:52 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 22:38:07 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 22:38:09 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 22:38:22 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.01677 seconds. 22:38:25 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 22:38:27 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 22:38:29 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 22:38:34 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 22:38:35 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 22:38:40 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 22:38:44 INFO - PROCESS | 4668 | Cycle 1(1): loaded http://localhost:53192/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53192/tests/dromaeo/cssquery-yui.html) 22:38:44 INFO - PROCESS | 4668 | RSS: Main: 219619328 22:38:44 INFO - PROCESS | 4668 | 22:38:48 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.0334 seconds. 22:38:50 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.01656 seconds. 22:38:51 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1 seconds. 22:39:07 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 22:39:08 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 2.00008 seconds. 22:39:09 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 22:39:11 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 22:39:13 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 22:39:15 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 22:39:21 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 22:39:23 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 22:39:25 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 22:39:27 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 22:39:29 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 22:39:31 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 22:39:42 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 22:39:47 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 22:39:50 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 22:39:52 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 22:39:58 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 22:40:00 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.01674 seconds. 22:40:10 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 22:40:14 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 22:40:16 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 22:40:19 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 22:40:28 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 22:40:32 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00008 seconds. 22:40:39 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 22:40:40 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 22:40:46 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 22:40:50 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 22:40:53 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 22:40:56 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 22:40:59 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 22:41:23 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 22:41:29 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 22:41:38 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 22:41:39 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 22:41:40 INFO - PROCESS | 4668 | [GFX1-]: Refresh driver waiting for the compositor for 2.01673 seconds. 22:41:47 INFO - PROCESS | 4668 | Cycle 1(1): loaded http://localhost:53192/tests/dromaeo/cssquery-yui.html (next: http://localhost:53192/tests/dromaeo/cssquery-dojo.html) 22:41:47 INFO - PROCESS | 4668 | RSS: Main: 310165504 22:41:47 INFO - PROCESS | 4668 | 22:41:47 INFO - PROCESS | 4668 | __start_tp_report 22:41:47 INFO - PROCESS | 4668 | _x_x_mozilla_page_load 22:41:47 INFO - PROCESS | 4668 | _x_x_mozilla_page_load_details 22:41:47 INFO - PROCESS | 4668 | |i|pagename|runs| 22:41:47 INFO - PROCESS | 4668 | |0;dojo.html;2562.1416825363503;2587.2626301504074;2621.239840446271;2627.461370419064;2635.20943716885;4607.28587069004;4664.556867097629;4751.786169622366;4762.976185119074;4772.04559088182;4694.201985662437;4704.082703872747;4741.193997020506;4747.976260118703;4805.423349198092;4284.9143017139795;4289.613934745872;4329.02596915693;4361.847335343264;4439.489458712241;4366.454193225847;4415.403920470743;4430.003249268921;4474.664400169984;4503.527129651388;4249.3413520904305;4384.276594361926;4400.801963911632;4407.955920440802;4502.144592527409;4302.612764851147;4308.612224899774;4372.868813935587;4378.343248512717;4381.978090109529;4308.375285583573;4329.696921215516;4381.693281470299;4390.626796722282;4398.076403955173;4685.484596694361;4702.27114797207;4725.196716558194;4735.526447355272;4782.928256076161;4891.8287859925085;5052.722100284483;5055.469175736532;5056.873578160576;5101.336826212606;4945.2829339745895;5006.874828129326;5079.339685840854;5081.187010078406;5152.974235128838;4739.218029025206;4748.715077095385;4749.026449577828;4753.33453316536;4807.423109226846;5187.922181167285;5188.11801993662;5192.45479224676;5195.272661827347;5253.264542963988;4801.735904525215;4853.684510506806;4950.925736113961;4954.826581069645;4986.850394488171;5099.974500127476;5103.260027296022;5103.87240318995;5107.33604631403;5163.97418012915;5032.521910418578;5067.037262920034;5067.315912351859;5118.692878427306;5135.281060651511;4848.296996935424;4919.0899683558655;4922.310876477296;5014.874628134253;5047.545720885138;4235.385869048971;4252.064545799919;4255.744655320691;4258.8296468140925;4263.339182426729;3723.0320116769835;3770.0763312988493;3776.584575696671;3795.3927371620407;3818.6372294631965;4281.614654681093;4283.7001409901;4284.614384705392;4324.827006919688;4335.34969754533;4912.336834527365;5074.264231686385;5075.746212689351;5075.974620126875;5082.695038297714;4157.272477316457;4195.223883581547;4241.893952651147;4248.065425606362;4297.871063868089;4520.389747384061;4523.570260825217;4531.932021019687;4539.228331183706;4555.339475775994;4714.245720684674;4750.7862146202815;4760.262159365304;4761.357216775691;4819.445763737145;4882.95117048825;4930.753462326941;5020.3724534433195;5057.165567681292;5067.341245638044;4775.307580400753;4775.6179505638775;4776.641751868554;4804.615630749601;4828.275758636232;4918.360613120271;4921.089598424303;4923.704577725348;4951.653384263067;4981.302617633607;4897.485763994871;4951.851444456672;4993.775280112331;4995.750212489288;5037.19404895215;4973.651844371004;4974.204127339608;4978.775955082103;5028.220625803006;5040.798368065236;4951.480094590016;4960.553550180501;4961;4963.379577552806;5027.044861476308;4752.786124624331;4805.9038819224115;4843.2250839865455;4894.094592500399;4962.602991760578;4921.557059864629;4988.376452943382;5005.074061298671;5052.873678158076;5053;4669.136209801198;4883.096627123993;4897.2654101885;4905.068037072945;4934.210526315772 22:41:47 INFO - PROCESS | 4668 | |1;ext.html;576.6626523483761;582.947534721875;591.5031373646136;591.9585629005971;594.7056207177446;27976.30059248517;38578.421323680166;40047.99880003005;40095.39856902149;43806;40348.19303613926;40454;40707.79646101773;40711.38932916008;40770.18459630813;7258;7552.131504876941;7701.152873183945;7707.6916923323;7708.768736937901;7144.464165187632;9777.217822574177;10033.147182489498;10046.497675116252;10369.585216591327;10012.199024078056;10118.645847395343;10119.645812396568;10123.544440500158;10127.442990635513;9866.112049915506;9950.30347875649;9955.402675839472;9959.103680668775;9964.202863770917;9722.173615242713;9784.51077446132;9801.852972205423;9828;9832.803343933152;35897.82051089754;36124;36177.27645447076;36184.63815361839;36211.4568281476;2988.2977500287416;3021.3957208558377;3477.3914564951033;3481.89554313371;3482.512448257246;27598.310042248904;28288.717112828814;28319.17691111715;28404.573931391045;28494.287642809097;3380.7802492837886;3499.160201551609;3556.288742251534;3578.4453409721536;3601.8019008954498;245659;245993.7700311505;246124;246908;248950;31497.8425107873;49367.753161233966;49649.50350496521;49860.25209621859;49870.501294986585;31852.681473185436;33748.325033499685;33749.49375759366;33769.83115084409;33772.32455350879;11764.294142351486;11834.763304733857;11906.583269585522;12001.519939202508;12021.699457513458;8885.733427997171;9081.45511269326;9289.953550232205;9529.809403811885;9590.904090959;7566.924330756732;7587.58268295238;7770.494917830436;7788;7834.216578342234;3095.65339077502;3104.4101620691995;3115.8753649854207;3117.5323701444513;3161.636411812625;824.6330382979636;926.3145272498302;946.5172761891484;967.4437198610827;971.9416834989923;27335.45329093407;27993;28270.858645707052;28350.432991340058;28488.85755571209;934.9579268932914;956.3496822160859;974.6004138303261;987.4420952162149;992.0377234082928;13751.518696845562;14493.92753036249;14645.121292722471;14793.482228121964;14903.329350179269;373044;377031;377145;377215;377512;46403;46681.29978050332;46793.53206467892;46914.53085469102;46931.53068469271;1081.7403823082561;1103.4648195625275;1144.9771004580027;1186.0985650905375;1206.324458303353;26609;27882.721172788013;27967.58048629313;28743.425131497672;28868.278293042003;39926.80036599799;40679.38980915348;40687.1862562753;40722;40742.38886416647;299221;301158;301233;301719;302066;24382.51234975326;24617.753822461545;25154.874225628755;25481.87259063693;26414.735852641996;40059.59940400559;40303.798481007405;40390.79804601076;40493.1901361977;41565.79217103895;35462.82268588641;35484.29031419409;35768.64231357653;35825.596568325964;36058.27883442369;34989;35190.824045879606;35343.646563534036;35371;35670;34695.306093878484;34975;35163.64836351604;35357.116072098404;35852.462213067345;30595.847020764755;33015.17462063371;33080.33839323248;33158.33683326368;33342;24619.63070553979;24987.250382488553;25101;25245.67418786474;25388.365290867878 22:41:47 INFO - PROCESS | 4668 | |2;jquery.html;342.1030386506819;369.64329422107676;371.3835033843819;374.567374682242;398.49391273083165;12348.691282717926;15846.683066338666;16026.83973160268;16830.24263908124;17538.210780514877;16344.75482867758;16663.083530405824;17007.744883826752;17197.570060748487;17200.483985480423;4924.113659541299;4992.301077849104;5012.122878496267;5027.321311622921;5030;3664.248828990064;3847.7883716395586;4976.950230497703;5067.797288108472;5071.264666623338;3811.2568049230413;3848.7113466489986;3872.0900588361715;3874.7093967952374;3875.050612599917;5878.118282257653;6017.578769486116;6021.879562408771;6026.186464827236;6027.7287522061615;5145.272107655543;5288.074586947308;5301.602379821529;5308.575313974873;5315.760790764425;20691.5861682767;20814.895925520275;20864.895675521526;20887.37337879866;20986.790132098635;1916.7795703493998;1928.4793105861338;2045.263705066175;2241.4732537853756;2254.661800729887;12757.9587266037;13236.13965092266;13355.532556360578;13399.330033498287;13982.510612128526;1703.1399143432486;1710.2133018811362;1737.4527023987403;1754.429810311654;1832.7342535332436;47219;64232.35767642357;65173.674131629516;65937.67031164862;71813.28186718118;9412.811743765224;9697.321187516805;9710.70867873965;9824.803503930025;10035.79928401428;13436.865631343757;13450.12574182675;13457.932710336581;13468.595942121752;13486.527971520949;6973.442124630017;7163.176234732969;7173.246809084971;7298.416126709851;7305.89041164383;6656.70044847983;6706.798796036127;6732.596044237362;6892.448604111759;6892.793216203522;6159.938400616026;6178.969105154535;6205.348438413902;6206.224221972254;6217.347178546278;1784.1881943715578;1799.4061959553317;1816.9273229070955;1829.6980998135425;1852.5924296654714;850.4599579267086;858.9656413743505;869.5261082709939;910.0626354854511;949.1125797379334;16867.156642167844;17316.567085822702;17875.553111172325;17902.46292611224;18160.636787264182;870.6256309786852;877.8858748362672;887.8313120507212;894.8970868350093;905.8686490458979;9277.396969196981;9495.810083798286;10280.845787313196;10355;10667.83998240027;401151;401721;402355;403037;406321;76244;79354.6032269835;80450;82060;82565.17434825575;951.0917074194128;962.2879069488667;966.9951650241704;1001.0740065439585;1002.834532302162;14796.63008424798;15855.841441585437;15863.603409914844;15986.840131598536;16944.40694575684;33071.834640827605;33934.83032584821;36610.26779464449;37742.8112859434;38957.6104238954;48732.269015965496;49316.50683493119;49485.50514494809;49806.50193498019;50709.74645126751;7539.170691224071;7594.696212151452;7773.222677732181;7941.411717656376;8246.752597421846;9092.636294548409;11932.22440541362;12119.939400302943;12309;12892.935535322264;9433.858492122761;9989.100980911753;10592.841107383241;10752.569897204025;10922.453877305945;9460.148586627236;9894.356866803635;10801.567937282422;11029.889701103208;11033.779324413626;10883.727906802076;10951.45242737876;11012.889871101186;11131.443427828413;11500.82748758786;7908.52548847071;8010.91989080125;8072.59637018135;8146.389020823581;8203.097659257357;9136.360454768368;10208.336458130198;10599.470026498799;10870;11371.715707107058 22:41:47 INFO - PROCESS | 4668 | |3;mootools.html;1101.1741194104422;1354.9864501354987;1392.6727219103511;1464.3776395032116;1696.4401747423344;6716.126903502544;7555.168931417546;7860.056793184812;7891.289783919446;8050.677972881078;7824.569648669335;7895.64469598868;7903.881441778363;7907.4069444791585;7907.841843163148;2230.944226394341;2245.955080898381;2246.70792796937;2247.179779380531;2251.88740562972;2187.2016713899393;2229.6766968789516;2240.6975058367075;2244.394013616323;2247.8763667998255;2187.2344679362254;2198.5822693688147;2203.394066631673;2206.735191776989;2251.234580242717;2174.097749433983;2192.550527141932;2193.1775584155944;2196.5826492966366;2203.4050806282376;2159.298228075866;2162.0919213930188;2163.5132095278436;2165.794249546306;2166.1876796201423;7658.463907526475;7737;7880.0937892142565;7883.369330453607;7894.368450523944;4421.535738747418;4612.815487380501;4616.746078965655;4621.953780462186;4624.907501849978;2826.23691603266;2918.3871387008753;2951.3064429858964;2958.9408211835644;2967.4806908790874;1006.7936073105069;1025.5795123999123;1028.7788125553043;1061.0821639281965;1073.3613499967507;10095;10501.264911456125;10512.264141510097;10574.52414641343;10878.564857405694;4022.336314508132;4115.115250221157;4210.831566737357;4236.046889449849;4245.511766146871;8414.158584141536;8419.284360829399;8428.072911979678;8429.957850210709;8432.198941100585;4488.438945131858;4499.212637788374;4499.257622492252;4503.797329120198;4506.549345065533;3615.439606860941;3640.3447379471418;3734.215814678948;4178.8537401190815;4179.770112643834;3498.1954150545516;3533.5229743984746;3550.0769799852224;3564.518789963322;3565.6969157621893;1007.2495990487134;1044.8454457824148;1060.6870973062964;1063.0698139128262;1073.5920350267004;686.2485578291762;703.869784089945;732.9230430804795;760.3802900635964;783.7766236622535;4866.31871537985;4922.335484709519;5151.922721159186;5160.354955630546;5207.661502002434;824.3611201318906;878.5519385113638;897.3180382908905;907.587047893207;908.9045650206765;3192.664770199142;3225.935481290361;3281.8030918144987;3312.93374132516;3484.651534846495;9244.260459163252;9689.176420004378;9777.804443911082;9779.559919803625;9809.313348065709;9552.092551207625;9724.75688107803;9736.269779766404;9737.07497787709;9837.360571562825;7329.230430804795;7470.36501897334;7474.85050298991;7475.2151024141685;7490.588017658972;4532.864014079583;4627.120847039052;4662.300654901792;5264.289320941624;5393.8112166074;8962.193402593797;9121.680741174026;9137.177654010906;9139.497327647043;9232;8965.865512017195;9211.447313161232;9221.49281789508;9254.583543740682;9312.255019598551;6772.05191273232;6882.8623427530165;6911.447084233148;6920.411765000032;6926.480513961373;6283.277423096402;6560.475161986934;7281.19906810261;7535.397168226419;7670.501417408074;6675.365840245169;6720.798376048726;6798.7280508779095;6829.487788415988;6980.232174460907;6517.055027020961;6521.771737989147;6611.834704132435;6648;6694.230163531256;5879.5002424794375;5947.940520594739;5956.076808094752;5968.343482217039;5971.253593300838;4422.601965823092;4430.756308403069;4439.4006809080365;4475.267862929959;4484.798184081659;4438.289873620205;4486.820527178877;4492.483364413004;4515.390422292949;4547.272436410159 22:41:47 INFO - PROCESS | 4668 | |4;prototype.html;294.7170716112532;296.47819837086735;297.54475652252063;303.6492850757375;312.1276033486406;4832.695172303476;4846.2972868934075;4858.688154198364;4880.438749543803;4883;4772.90454190916;4808.783604737787;4825.6622036457375;4829.382156977408;4837.153498137829;3617.2584620152807;3727.850885964558;3730.235301763132;3821.948964034899;3827.1962887793597;3827.406751953438;3833.731638785286;3835.6931445484433;3836.731428799985;3846.7114966377494;3792.3363411403034;3796.4874741909903;3810.5427348718054;3815.809209539512;3822.789746563938;3637.3816451203224;3710.7959062251566;3746.2694774518845;3795.2788970095594;3808.6762625176893;3363.495475678668;3374.9662503375143;3377.4764911438765;3380.154961259685;3382.0868365541414;4715.31627913954;4740.07568524138;4748.335233067373;4749.121412538691;4756.28655701644;4207.347861081537;4337.913241735179;4355.063661312833;4370.8033138508845;4372.256716358227;4980.576650984671;5004.449510553836;5023.965294055914;5028.4971502849785;5039.168537191359;3701.1117331840433;3703.1112532992156;3717.665410113103;3719.925601487982;3726.5341832270965;5169.508896654812;5249.763760630781;5267.157254839208;5300.761465734013;5343.625946183769;3711.6102809205186;3746.089494357843;3750.249950010009;3761.5486141663177;3768.246350729865;3809.8857034289017;3811.4282857571584;3816.8473261069803;3819.2170605025904;3819.751716138442;4307.138572285556;4309.396684464177;4320.243957307459;4322.740635561876;4324.070324880166;4815.566599006036;4983.700977941335;5020.974895125574;5027.723475208899;5048.6718363307;1307.3659275251496;1318.228836130855;1323.4904561743797;1323.503686117706;1326.8208791813174;832.4589017138908;859.5186695450568;865.1435079271475;879.7404765594165;883.5008220355479;4183;4220.472440944882;4331.198728235287;4331.263685173528;4338.717983331074;5133.666311689728;5155.74221288934;5161.509656582619;5163.302954101148;5206.479352064764;4351.456067991501;4356.190257284097;4359.782010899506;4366.410534577855;4414.911701765946;2615.738426157407;2735.3435175557725;2737.86310684465;2755.5040092783092;2762.1713485954133;4888.242322440027;4897.41231052276;4909.275352179575;4927.679700819435;4945.9366236259375;5071.39143302806;5282.102042652758;5299.258103865462;5328.307320048369;5328.387235467893;4867.561919427198;4905.533974272438;4920.138975679313;4921.458639549575;4925.655204135676;5187.066328060985;5204.531592156724;5230.607704422107;5232.790688372423;5246.186841039645;4950.282209079592;5096.439391666988;5097.617678674188;5098.7705553250935;5119.158866828946;4868.099401610713;4897.877553061059;4899.265110233494;4903.298010002425;4908.460069392436;3780.5822816443833;3793.4689143519377;3800.201957588937;3804.505414296124;3816.3702989007616;4981;5185.870353241199;5205.323307969939;5215.965773348321;5247.921281180709;4950.529699678525;4986.750662466789;4988.55103040728;5002.199208284942;5033.974830125826;4958.826441074545;4978.701277923336;4980.477049909708;5019.719971407268;5030.949690503048;4735.129623798649;4918.901621967612;4930.852074437773;4976.900461990812;4986.276989836526;4883.706977581356;4896.853094407174;5010.169254371269;5095.898082038412;5116.411612664591;4927.359443272351;4935.580475659465;4950.381202349707;4986.376702912136;4992.975035124947 22:41:47 INFO - PROCESS | 4668 | |5;yui.html;613.2242712968094;643.0932385336677;653.6764301670673;715.7459102018784;716.9103862017248;12842.293673847946;14370.20963846988;14375.424983000667;14384.784228236558;14388.496402625897;12967.935160324185;13010.73978520429;13028.218306901592;13031.087823852335;13110.475580976774;606.0999415867433;620.6059152438189;736.0394684936156;736.694271877173;749.134749364485;759.7758661194961;760.0157795654641;760.9505382150143;761.6496411650647;762.2073044034198;799.1968072087544;800.4756884240832;800.4796882026671;800.8878756974028;800.9439339246255;635.0949896397638;649.422014407178;770.9575973321465;794.3406972213107;800.1438460846896;593.4718100890211;594.2542109652402;594.316535983618;594.4174708785371;594.4768603628822;13192.406341714646;13208.33958302081;13239.20564766117;13243.668908277274;13254.40355184019;12391.442385092692;12424.627261182179;12527.874721252761;13030.218186908722;13335.666608334772;11419.429028548539;11465.197436179471;11573.652790416301;11810.409479526075;12151.696207594792;3976.6619837313865;3992.1017771001584;4106.080387486423;4142.730722503058;4234.767087810169;62802;63004.36995630077;63224.683876580784;64233.67883160601;64265.67867160681;10005.44970026641;10119.139873110867;10318.690439286833;10610.416427096583;10626.468676566295;19479.513012174524;19491.707624385646;19565.51086222856;19575.510612234808;20461.18155273802;6624.768133115318;6627.237867645186;6684.498662600325;6722;6746.932530674729;3525.9118522036642;3533.3463309287863;3549.148204430918;3553.2538166984705;3554.2180720241504;2788.9721102789117;2925.8683359248885;2927.209653393572;2928.443595716807;2929.150546341537;458.1478450082843;529.8675331167208;542.0459990416895;545.6562365709657;559.5970900951309;380.8990617486368;504.7123139810273;505.79262502374587;521.291044179915;522.1254398881857;7327.670254838545;7895.723649672349;8073.555954422446;8075;8169.5506747129475;461.4140042146455;464.05796233645754;512.8615273876107;516.6770768269831;524.5881982643607;3563.590187128513;3751.4560388744026;3790.5830358660523;3852.5954774748247;3973.0663294125857;59752.70123649441;59914.70042649759;60333.39666603278;60501.69749151226;104243.4787826056;67535.66232168808;89593.10406895979;91859;92916;95013.5249323749;49560;55162.448375516535;78078.60960695274;79652.20347796564;80224;6458.192725909262;6926.757563485254;6927.272636373108;6940.618265995418;7241.312075352833;42214.57785422107;42714;43275.35086973635;45178.54821451743;45388.773056135826;54171;59261.70369148126;59858.40141598703;60406.697966509884;60862;8898.644054237759;9064.138906803842;9125.77185570366;9161.175494205287;9204.907950920406;9400.764980875532;9590.712278631652;9636.373635713657;9732.41605503672;9911.603535858485;9650.324477286804;9767.853482197916;10516.894831051592;10761.30051546647;10808.351498910091;9837.262205334771;10043.899561004297;10378.325408848401;10775.245732798629;10780.892191077988;9622.085901839315;9840.931920061317;9850.211983041483;9887.555060022172;9909.355891867006;7533.886991695019;7590.39276857839;7706;7855.293023627901;8029.959850200712;7708.152103268748;8071.23323284287;8240;8284.08875023759;8349.624266907882 22:41:47 INFO - PROCESS | 4668 | __end_tp_report 22:41:47 INFO - PROCESS | 4668 | __start_cc_report 22:41:47 INFO - PROCESS | 4668 | _x_x_mozilla_cycle_collect,920 22:41:47 INFO - PROCESS | 4668 | __end_cc_report 22:41:47 INFO - PROCESS | 4668 | __startTimestamp1474177307961__endTimestamp 22:41:47 INFO - PROCESS | 4668 | 22:41:47 INFO - PROCESS | 4668 | ------- Summary: start ------- 22:41:47 INFO - PROCESS | 4668 | Number of tests: 6 22:41:47 INFO - PROCESS | 4668 | 22:41:47 INFO - PROCESS | 4668 | [#0] dojo.html Cycles:165 Average:4668.26 Median:4801.74 stddev:493.80 (10.3%) stddev-sans-first:466.86 22:41:47 INFO - PROCESS | 4668 | Values: 2562.1 2587.3 2621.2 2627.5 2635.2 4607.3 4664.6 4751.8 4763.0 4772.0 4694.2 4704.1 4741.2 4748.0 4805.4 4284.9 4289.6 4329.0 4361.8 4439.5 4366.5 4415.4 4430.0 4474.7 4503.5 4249.3 4384.3 4400.8 4408.0 4502.1 4302.6 4308.6 4372.9 4378.3 4382.0 4308.4 4329.7 4381.7 4390.6 4398.1 4685.5 4702.3 4725.2 4735.5 4782.9 4891.8 5052.7 5055.5 5056.9 5101.3 4945.3 5006.9 5079.3 5081.2 5153.0 4739.2 4748.7 4749.0 4753.3 4807.4 5187.9 5188.1 5192.5 5195.3 5253.3 4801.7 4853.7 4950.9 4954.8 4986.9 5100.0 5103.3 5103.9 5107.3 5164.0 5032.5 5067.0 5067.3 5118.7 5135.3 4848.3 4919.1 4922.3 5014.9 5047.5 4235.4 4252.1 4255.7 4258.8 4263.3 3723.0 3770.1 3776.6 3795.4 3818.6 4281.6 4283.7 4284.6 4324.8 4335.3 4912.3 5074.3 5075.7 5076.0 5082.7 4157.3 4195.2 4241.9 4248.1 4297.9 4520.4 4523.6 4531.9 4539.2 4555.3 4714.2 4750.8 4760.3 4761.4 4819.4 4883.0 4930.8 5020.4 5057.2 5067.3 4775.3 4775.6 4776.6 4804.6 4828.3 4918.4 4921.1 4923.7 4951.7 4981.3 4897.5 4951.9 4993.8 4995.8 5037.2 4973.7 4974.2 4978.8 5028.2 5040.8 4951.5 4960.6 4961.0 4963.4 5027.0 4752.8 4805.9 4843.2 4894.1 4962.6 4921.6 4988.4 5005.1 5052.9 5053.0 4669.1 4883.1 4897.3 4905.1 4934.2 22:41:47 INFO - PROCESS | 4668 | 22:41:47 INFO - PROCESS | 4668 | [#1] ext.html Cycles:180 Average:45101.23 Median:35473.56 stddev:82321.47 (232.1%) stddev-sans-first:82484.53 22:41:47 INFO - PROCESS | 4668 | Values: 576.7 582.9 591.5 592.0 594.7 27976.3 38578.4 40048.0 40095.4 43806.0 40348.2 40454.0 40707.8 40711.4 40770.2 7258.0 7552.1 7701.2 7707.7 7708.8 7144.5 9777.2 10033.1 10046.5 10369.6 10012.2 10118.6 10119.6 10123.5 10127.4 9866.1 9950.3 9955.4 9959.1 9964.2 9722.2 9784.5 9801.9 9828.0 9832.8 35897.8 36124.0 36177.3 36184.6 36211.5 2988.3 3021.4 3477.4 3481.9 3482.5 27598.3 28288.7 28319.2 28404.6 28494.3 3380.8 3499.2 3556.3 3578.4 3601.8 245659.0 245993.8 246124.0 246908.0 248950.0 31497.8 49367.8 49649.5 49860.3 49870.5 31852.7 33748.3 33749.5 33769.8 33772.3 11764.3 11834.8 11906.6 12001.5 12021.7 8885.7 9081.5 9290.0 9529.8 9590.9 7566.9 7587.6 7770.5 7788.0 7834.2 3095.7 3104.4 3115.9 3117.5 3161.6 824.6 926.3 946.5 967.4 971.9 27335.5 27993.0 28270.9 28350.4 28488.9 935.0 956.3 974.6 987.4 992.0 13751.5 14493.9 14645.1 14793.5 14903.3 373044.0 377031.0 377145.0 377215.0 377512.0 46403.0 46681.3 46793.5 46914.5 46931.5 1081.7 1103.5 1145.0 1186.1 1206.3 26609.0 27882.7 27967.6 28743.4 28868.3 39926.8 40679.4 40687.2 40722.0 40742.4 299221.0 301158.0 301233.0 301719.0 302066.0 24382.5 24617.8 25154.9 25481.9 26414.7 40059.6 40303.8 40390.8 40493.2 41565.8 35462.8 35484.3 35768.6 35825.6 36058.3 34989.0 35190.8 35343.6 35371.0 35670.0 34695.3 34975.0 35163.6 35357.1 35852.5 30595.8 33015.2 33080.3 33158.3 33342.0 24619.6 24987.3 25101.0 25245.7 25388.4 22:41:47 INFO - PROCESS | 4668 | 22:41:47 INFO - PROCESS | 4668 | [#2] jquery.html Cycles:180 Average:24682.14 Median:19678.05 stddev:66371.52 (337.3%) stddev-sans-first:66532.55 22:41:47 INFO - PROCESS | 4668 | Values: 342.1 369.6 371.4 374.6 398.5 12348.7 15846.7 16026.8 16830.2 17538.2 16344.8 16663.1 17007.7 17197.6 17200.5 4924.1 4992.3 5012.1 5027.3 5030.0 3664.2 3847.8 4977.0 5067.8 5071.3 3811.3 3848.7 3872.1 3874.7 3875.1 5878.1 6017.6 6021.9 6026.2 6027.7 5145.3 5288.1 5301.6 5308.6 5315.8 20691.6 20814.9 20864.9 20887.4 20986.8 1916.8 1928.5 2045.3 2241.5 2254.7 12758.0 13236.1 13355.5 13399.3 13982.5 1703.1 1710.2 1737.5 1754.4 1832.7 47219.0 64232.4 65173.7 65937.7 71813.3 9412.8 9697.3 9710.7 9824.8 10035.8 13436.9 13450.1 13457.9 13468.6 13486.5 6973.4 7163.2 7173.2 7298.4 7305.9 6656.7 6706.8 6732.6 6892.4 6892.8 6159.9 6179.0 6205.3 6206.2 6217.3 1784.2 1799.4 1816.9 1829.7 1852.6 850.5 859.0 869.5 910.1 949.1 16867.2 17316.6 17875.6 17902.5 18160.6 870.6 877.9 887.8 894.9 905.9 9277.4 9495.8 10280.8 10355.0 10667.8 401151.0 401721.0 402355.0 403037.0 406321.0 76244.0 79354.6 80450.0 82060.0 82565.2 951.1 962.3 967.0 1001.1 1002.8 14796.6 15855.8 15863.6 15986.8 16944.4 33071.8 33934.8 36610.3 37742.8 38957.6 48732.3 49316.5 49485.5 49806.5 50709.7 7539.2 7594.7 7773.2 7941.4 8246.8 9092.6 11932.2 12119.9 12309.0 12892.9 9433.9 9989.1 10592.8 10752.6 10922.5 9460.1 9894.4 10801.6 11029.9 11033.8 10883.7 10951.5 11012.9 11131.4 11500.8 7908.5 8010.9 8072.6 8146.4 8203.1 9136.4 10208.3 10599.5 10870.0 11371.7 22:41:47 INFO - PROCESS | 4668 | 22:41:47 INFO - PROCESS | 4668 | [#3] mootools.html Cycles:180 Average:5072.58 Median:4626.01 stddev:2873.81 (62.1%) stddev-sans-first:2866.37 22:41:47 INFO - PROCESS | 4668 | Values: 1101.2 1355.0 1392.7 1464.4 1696.4 6716.1 7555.2 7860.1 7891.3 8050.7 7824.6 7895.6 7903.9 7907.4 7907.8 2230.9 2246.0 2246.7 2247.2 2251.9 2187.2 2229.7 2240.7 2244.4 2247.9 2187.2 2198.6 2203.4 2206.7 2251.2 2174.1 2192.6 2193.2 2196.6 2203.4 2159.3 2162.1 2163.5 2165.8 2166.2 7658.5 7737.0 7880.1 7883.4 7894.4 4421.5 4612.8 4616.7 4622.0 4624.9 2826.2 2918.4 2951.3 2958.9 2967.5 1006.8 1025.6 1028.8 1061.1 1073.4 10095.0 10501.3 10512.3 10574.5 10878.6 4022.3 4115.1 4210.8 4236.0 4245.5 8414.2 8419.3 8428.1 8430.0 8432.2 4488.4 4499.2 4499.3 4503.8 4506.5 3615.4 3640.3 3734.2 4178.9 4179.8 3498.2 3533.5 3550.1 3564.5 3565.7 1007.2 1044.8 1060.7 1063.1 1073.6 686.2 703.9 732.9 760.4 783.8 4866.3 4922.3 5151.9 5160.4 5207.7 824.4 878.6 897.3 907.6 908.9 3192.7 3225.9 3281.8 3312.9 3484.7 9244.3 9689.2 9777.8 9779.6 9809.3 9552.1 9724.8 9736.3 9737.1 9837.4 7329.2 7470.4 7474.9 7475.2 7490.6 4532.9 4627.1 4662.3 5264.3 5393.8 8962.2 9121.7 9137.2 9139.5 9232.0 8965.9 9211.4 9221.5 9254.6 9312.3 6772.1 6882.9 6911.4 6920.4 6926.5 6283.3 6560.5 7281.2 7535.4 7670.5 6675.4 6720.8 6798.7 6829.5 6980.2 6517.1 6521.8 6611.8 6648.0 6694.2 5879.5 5947.9 5956.1 5968.3 5971.3 4422.6 4430.8 4439.4 4475.3 4484.8 4438.3 4486.8 4492.5 4515.4 4547.3 22:41:47 INFO - PROCESS | 4668 | 22:41:47 INFO - PROCESS | 4668 | [#4] prototype.html Cycles:180 Average:4200.48 Median:4831.04 stddev:1203.76 (24.9%) stddev-sans-first:1170.89 22:41:47 INFO - PROCESS | 4668 | Values: 294.7 296.5 297.5 303.6 312.1 4832.7 4846.3 4858.7 4880.4 4883.0 4772.9 4808.8 4825.7 4829.4 4837.2 3617.3 3727.9 3730.2 3821.9 3827.2 3827.4 3833.7 3835.7 3836.7 3846.7 3792.3 3796.5 3810.5 3815.8 3822.8 3637.4 3710.8 3746.3 3795.3 3808.7 3363.5 3375.0 3377.5 3380.2 3382.1 4715.3 4740.1 4748.3 4749.1 4756.3 4207.3 4337.9 4355.1 4370.8 4372.3 4980.6 5004.4 5024.0 5028.5 5039.2 3701.1 3703.1 3717.7 3719.9 3726.5 5169.5 5249.8 5267.2 5300.8 5343.6 3711.6 3746.1 3750.2 3761.5 3768.2 3809.9 3811.4 3816.8 3819.2 3819.8 4307.1 4309.4 4320.2 4322.7 4324.1 4815.6 4983.7 5021.0 5027.7 5048.7 1307.4 1318.2 1323.5 1323.5 1326.8 832.5 859.5 865.1 879.7 883.5 4183.0 4220.5 4331.2 4331.3 4338.7 5133.7 5155.7 5161.5 5163.3 5206.5 4351.5 4356.2 4359.8 4366.4 4414.9 2615.7 2735.3 2737.9 2755.5 2762.2 4888.2 4897.4 4909.3 4927.7 4945.9 5071.4 5282.1 5299.3 5328.3 5328.4 4867.6 4905.5 4920.1 4921.5 4925.7 5187.1 5204.5 5230.6 5232.8 5246.2 4950.3 5096.4 5097.6 5098.8 5119.2 4868.1 4897.9 4899.3 4903.3 4908.5 3780.6 3793.5 3800.2 3804.5 3816.4 4981.0 5185.9 5205.3 5216.0 5247.9 4950.5 4986.8 4988.6 5002.2 5034.0 4958.8 4978.7 4980.5 5019.7 5030.9 4735.1 4918.9 4930.9 4976.9 4986.3 4883.7 4896.9 5010.2 5095.9 5116.4 4927.4 4935.6 4950.4 4986.4 4993.0 22:41:47 INFO - PROCESS | 4668 | 22:41:47 INFO - PROCESS | 4668 | [#5] yui.html Cycles:180 Average:16458.71 Median:594.45 stddev:23346.57 (3927.4%) stddev-sans-first:23381.75 22:41:47 INFO - PROCESS | 4668 | Values: 613.2 643.1 653.7 715.7 716.9 12842.3 14370.2 14375.4 14384.8 14388.5 12967.9 13010.7 13028.2 13031.1 13110.5 606.1 620.6 736.0 736.7 749.1 759.8 760.0 761.0 761.6 762.2 799.2 800.5 800.5 800.9 800.9 635.1 649.4 771.0 794.3 800.1 593.5 594.3 594.3 594.4 594.5 13192.4 13208.3 13239.2 13243.7 13254.4 12391.4 12424.6 12527.9 13030.2 13335.7 11419.4 11465.2 11573.7 11810.4 12151.7 3976.7 3992.1 4106.1 4142.7 4234.8 62802.0 63004.4 63224.7 64233.7 64265.7 10005.4 10119.1 10318.7 10610.4 10626.5 19479.5 19491.7 19565.5 19575.5 20461.2 6624.8 6627.2 6684.5 6722.0 6746.9 3525.9 3533.3 3549.1 3553.3 3554.2 2789.0 2925.9 2927.2 2928.4 2929.2 458.1 529.9 542.0 545.7 559.6 380.9 504.7 505.8 521.3 522.1 7327.7 7895.7 8073.6 8075.0 8169.6 461.4 464.1 512.9 516.7 524.6 3563.6 3751.5 3790.6 3852.6 3973.1 59752.7 59914.7 60333.4 60501.7 104243.5 67535.7 89593.1 91859.0 92916.0 95013.5 49560.0 55162.4 78078.6 79652.2 80224.0 6458.2 6926.8 6927.3 6940.6 7241.3 42214.6 42714.0 43275.4 45178.5 45388.8 54171.0 59261.7 59858.4 60406.7 60862.0 8898.6 9064.1 9125.8 9161.2 9204.9 9400.8 9590.7 9636.4 9732.4 9911.6 9650.3 9767.9 10516.9 10761.3 10808.4 9837.3 10043.9 10378.3 10775.2 10780.9 9622.1 9840.9 9850.2 9887.6 9909.4 7533.9 7590.4 7706.0 7855.3 8030.0 7708.2 8071.2 8240.0 8284.1 8349.6 22:41:47 INFO - PROCESS | 4668 | -------- Summary: end -------- 22:41:47 INFO - PROCESS | 4668 | 22:41:48 INFO - TEST-INFO | 4668: exit 0 22:41:48 INFO - TEST-OK | dromaeo_css | took 1121786ms 22:41:48 INFO - TEST-START | kraken 22:41:48 INFO - operating with platform_type : linux_ 22:41:48 INFO - Initialising browser for kraken test... 22:41:48 INFO - TEST-INFO | started process 4975 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeJaubx/profile http://localhost:53192/getInfo.html) 22:41:53 INFO - PROCESS | 4975 | __metrics Screen width/height:1600/1200 22:41:53 INFO - PROCESS | 4975 | colorDepth:24 22:41:53 INFO - PROCESS | 4975 | Browser inner width/height: 1024/697 22:41:53 INFO - PROCESS | 4975 | __metrics 22:41:54 INFO - PROCESS | 4975 | 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" 22:41:54 INFO - PROCESS | 4975 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:41:54 INFO - PROCESS | 4975 | console.error: PushService: 22:41:54 INFO - PROCESS | 4975 | stateChangeProcessEnqueue: Error transitioning state 22:41:54 INFO - PROCESS | 4975 | UnknownError 22:41:55 INFO - TEST-INFO | 4975: exit 0 22:41:55 INFO - Browser initialized. 22:41:55 INFO - Running cycle 1/1 for kraken test... 22:41:55 INFO - TEST-INFO | started process 5055 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeJaubx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:42:07 INFO - PROCESS | 5055 | RSS: Main: 174542848 22:42:07 INFO - PROCESS | 5055 | 22:42:10 INFO - PROCESS | 5055 | Cycle 1(1): loaded http://localhost:53192/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53192/tests/kraken/driver.html?testName=audio-beat-detection) 22:42:11 INFO - PROCESS | 5055 | RSS: Main: 241729536 22:42:11 INFO - PROCESS | 5055 | 22:42:14 INFO - PROCESS | 5055 | Cycle 1(1): loaded http://localhost:53192/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53192/tests/kraken/driver.html?testName=audio-dft) 22:42:15 INFO - PROCESS | 5055 | RSS: Main: 216891392 22:42:15 INFO - PROCESS | 5055 | 22:42:18 INFO - PROCESS | 5055 | Cycle 1(1): loaded http://localhost:53192/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53192/tests/kraken/driver.html?testName=audio-fft) 22:42:18 INFO - PROCESS | 5055 | RSS: Main: 299737088 22:42:18 INFO - PROCESS | 5055 | 22:42:21 INFO - PROCESS | 5055 | Cycle 1(1): loaded http://localhost:53192/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53192/tests/kraken/driver.html?testName=audio-oscillator) 22:42:21 INFO - PROCESS | 5055 | RSS: Main: 208994304 22:42:21 INFO - PROCESS | 5055 | 22:42:24 INFO - PROCESS | 5055 | Cycle 1(1): loaded http://localhost:53192/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53192/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:42:24 INFO - PROCESS | 5055 | RSS: Main: 212574208 22:42:24 INFO - PROCESS | 5055 | 22:42:27 INFO - PROCESS | 5055 | Cycle 1(1): loaded http://localhost:53192/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53192/tests/kraken/driver.html?testName=imaging-darkroom) 22:42:28 INFO - PROCESS | 5055 | RSS: Main: 249008128 22:42:28 INFO - PROCESS | 5055 | 22:42:31 INFO - PROCESS | 5055 | Cycle 1(1): loaded http://localhost:53192/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53192/tests/kraken/driver.html?testName=imaging-desaturate) 22:42:32 INFO - PROCESS | 5055 | RSS: Main: 248623104 22:42:32 INFO - PROCESS | 5055 | 22:42:35 INFO - PROCESS | 5055 | Cycle 1(1): loaded http://localhost:53192/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53192/tests/kraken/driver.html?testName=json-parse-financial) 22:42:36 INFO - PROCESS | 5055 | RSS: Main: 248168448 22:42:36 INFO - PROCESS | 5055 | 22:42:37 INFO - PROCESS | 5055 | Cycle 1(1): loaded http://localhost:53192/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53192/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:42:38 INFO - PROCESS | 5055 | RSS: Main: 210743296 22:42:38 INFO - PROCESS | 5055 | 22:42:40 INFO - PROCESS | 5055 | Cycle 1(1): loaded http://localhost:53192/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53192/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:42:40 INFO - PROCESS | 5055 | RSS: Main: 218521600 22:42:40 INFO - PROCESS | 5055 | 22:42:42 INFO - PROCESS | 5055 | Cycle 1(1): loaded http://localhost:53192/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53192/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:42:43 INFO - PROCESS | 5055 | RSS: Main: 222740480 22:42:43 INFO - PROCESS | 5055 | 22:42:46 INFO - PROCESS | 5055 | Cycle 1(1): loaded http://localhost:53192/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53192/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:42:47 INFO - PROCESS | 5055 | RSS: Main: 223408128 22:42:47 INFO - PROCESS | 5055 | 22:42:50 INFO - PROCESS | 5055 | Cycle 1(1): loaded http://localhost:53192/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53192/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:42:50 INFO - PROCESS | 5055 | RSS: Main: 221200384 22:42:50 INFO - PROCESS | 5055 | 22:42:52 INFO - PROCESS | 5055 | Cycle 1(1): loaded http://localhost:53192/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53192/tests/kraken/driver.html?testName=ai-astar) 22:42:52 INFO - PROCESS | 5055 | RSS: Main: 273088512 22:42:52 INFO - PROCESS | 5055 | 22:42:52 INFO - PROCESS | 5055 | __start_tp_report 22:42:52 INFO - PROCESS | 5055 | _x_x_mozilla_page_load 22:42:52 INFO - PROCESS | 5055 | _x_x_mozilla_page_load_details 22:42:52 INFO - PROCESS | 5055 | |i|pagename|runs| 22:42:52 INFO - PROCESS | 5055 | |0;ai-astar;113;114;115;116;115;115;114;114;113;114 22:42:52 INFO - PROCESS | 5055 | |1;audio-beat-detection;155;128;127;174;126;123;124;121;156;125 22:42:52 INFO - PROCESS | 5055 | |2;audio-dft;162;162;162;162;161;160;163;163;164;163 22:42:52 INFO - PROCESS | 5055 | |3;audio-fft;76;76;77;108;77;77;77;77;109;76 22:42:52 INFO - PROCESS | 5055 | |4;audio-oscillator;86;85;112;84;84;84;116;84;83;113 22:42:52 INFO - PROCESS | 5055 | |5;imaging-gaussian-blur;117;116;117;117;118;116;117;117;117;117 22:42:52 INFO - PROCESS | 5055 | |6;imaging-darkroom;147;146;146;146;147;147;147;146;146;146 22:42:52 INFO - PROCESS | 5055 | |7;imaging-desaturate;95;95;94;95;95;94;95;95;95;95 22:42:52 INFO - PROCESS | 5055 | |8;json-parse-financial;65;76;62;63;63;65;65;63;63;64 22:42:52 INFO - PROCESS | 5055 | |9;json-stringify-tinderbox;66;65;67;65;66;66;66;67;65;66 22:42:52 INFO - PROCESS | 5055 | |10;stanford-crypto-aes;84;83;83;83;83;82;85;81;83;82 22:42:52 INFO - PROCESS | 5055 | |11;stanford-crypto-ccm;145;134;141;134;139;135;135;132;186;144 22:42:52 INFO - PROCESS | 5055 | |12;stanford-crypto-pbkdf2;181;173;176;176;176;181;174;181;176;175 22:42:52 INFO - PROCESS | 5055 | |13;stanford-crypto-sha256-iterative;69;70;69;69;68;69;69;68;69;68 22:42:52 INFO - PROCESS | 5055 | __end_tp_report 22:42:52 INFO - PROCESS | 5055 | __start_cc_report 22:42:52 INFO - PROCESS | 5055 | _x_x_mozilla_cycle_collect,1982 22:42:52 INFO - PROCESS | 5055 | __end_cc_report 22:42:52 INFO - PROCESS | 5055 | __startTimestamp1474177372789__endTimestamp 22:42:52 INFO - PROCESS | 5055 | 22:42:52 INFO - PROCESS | 5055 | ------- Summary: start ------- 22:42:52 INFO - PROCESS | 5055 | Number of tests: 14 22:42:52 INFO - PROCESS | 5055 | 22:42:52 INFO - PROCESS | 5055 | [#0] ai-astar Cycles:10 Average:114.30 Median:114.50 stddev:0.95 (0.8%) stddev-sans-first:0.88 22:42:52 INFO - PROCESS | 5055 | Values: 113.0 114.0 115.0 116.0 115.0 115.0 114.0 114.0 113.0 114.0 22:42:52 INFO - PROCESS | 5055 | 22:42:52 INFO - PROCESS | 5055 | [#1] audio-beat-detection Cycles:10 Average:135.90 Median:127.50 stddev:18.59 (14.6%) stddev-sans-first:18.38 22:42:52 INFO - PROCESS | 5055 | Values: 155.0 128.0 127.0 174.0 126.0 123.0 124.0 121.0 156.0 125.0 22:42:52 INFO - PROCESS | 5055 | 22:42:52 INFO - PROCESS | 5055 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.50 stddev:1.14 (0.7%) stddev-sans-first:1.20 22:42:52 INFO - PROCESS | 5055 | Values: 162.0 162.0 162.0 162.0 161.0 160.0 163.0 163.0 164.0 163.0 22:42:52 INFO - PROCESS | 5055 | 22:42:52 INFO - PROCESS | 5055 | [#3] audio-fft Cycles:10 Average:83.00 Median:77.00 stddev:13.45 (17.5%) stddev-sans-first:14.02 22:42:52 INFO - PROCESS | 5055 | Values: 76.0 76.0 77.0 108.0 77.0 77.0 77.0 77.0 109.0 76.0 22:42:52 INFO - PROCESS | 5055 | 22:42:52 INFO - PROCESS | 5055 | [#4] audio-oscillator Cycles:10 Average:93.10 Median:84.00 stddev:14.25 (17.0%) stddev-sans-first:14.88 22:42:52 INFO - PROCESS | 5055 | Values: 86.0 85.0 112.0 84.0 84.0 84.0 116.0 84.0 83.0 113.0 22:42:52 INFO - PROCESS | 5055 | 22:42:52 INFO - PROCESS | 5055 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 22:42:52 INFO - PROCESS | 5055 | Values: 117.0 116.0 117.0 117.0 118.0 116.0 117.0 117.0 117.0 117.0 22:42:52 INFO - PROCESS | 5055 | 22:42:52 INFO - PROCESS | 5055 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 22:42:52 INFO - PROCESS | 5055 | Values: 147.0 146.0 146.0 146.0 147.0 147.0 147.0 146.0 146.0 146.0 22:42:52 INFO - PROCESS | 5055 | 22:42:52 INFO - PROCESS | 5055 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:42:52 INFO - PROCESS | 5055 | Values: 95.0 95.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 22:42:52 INFO - PROCESS | 5055 | 22:42:52 INFO - PROCESS | 5055 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:64.50 stddev:4.04 (6.3%) stddev-sans-first:4.28 22:42:52 INFO - PROCESS | 5055 | Values: 65.0 76.0 62.0 63.0 63.0 65.0 65.0 63.0 63.0 64.0 22:42:52 INFO - PROCESS | 5055 | 22:42:52 INFO - PROCESS | 5055 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 22:42:52 INFO - PROCESS | 5055 | Values: 66.0 65.0 67.0 65.0 66.0 66.0 66.0 67.0 65.0 66.0 22:42:52 INFO - PROCESS | 5055 | 22:42:52 INFO - PROCESS | 5055 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:1.10 (1.3%) stddev-sans-first:1.09 22:42:52 INFO - PROCESS | 5055 | Values: 84.0 83.0 83.0 83.0 83.0 82.0 85.0 81.0 83.0 82.0 22:42:52 INFO - PROCESS | 5055 | 22:42:52 INFO - PROCESS | 5055 | [#11] stanford-crypto-ccm Cycles:10 Average:142.50 Median:140.00 stddev:15.93 (11.4%) stddev-sans-first:16.87 22:42:52 INFO - PROCESS | 5055 | Values: 145.0 134.0 141.0 134.0 139.0 135.0 135.0 132.0 186.0 144.0 22:42:52 INFO - PROCESS | 5055 | 22:42:52 INFO - PROCESS | 5055 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.90 Median:176.00 stddev:3.00 (1.7%) stddev-sans-first:2.79 22:42:52 INFO - PROCESS | 5055 | Values: 181.0 173.0 176.0 176.0 176.0 181.0 174.0 181.0 176.0 175.0 22:42:52 INFO - PROCESS | 5055 | 22:42:52 INFO - PROCESS | 5055 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 22:42:52 INFO - PROCESS | 5055 | Values: 69.0 70.0 69.0 69.0 68.0 69.0 69.0 68.0 69.0 68.0 22:42:52 INFO - PROCESS | 5055 | -------- Summary: end -------- 22:42:52 INFO - PROCESS | 5055 | 22:42:54 INFO - TEST-INFO | 5055: exit 0 22:42:54 INFO - TEST-OK | kraken | took 65123ms 22:42:54 INFO - SUITE-END | took 1186s 22:42:54 INFO - Completed test suite (00:19:47) 22:42:54 INFO - javascript benchmark 22:42:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2562.1416825363503, 2587.2626301504074, 2621.239840446271, 2627.461370419064, 2635.20943716885, 4607.28587069004, 4664.556867097629, 4751.786169622366, 4762.976185119074, 4772.04559088182, 4694.201985662437, 4704.082703872747, 4741.193997020506, 4747.976260118703, 4805.423349198092, 4284.9143017139795, 4289.613934745872, 4329.02596915693, 4361.847335343264, 4439.489458712241, 4366.454193225847, 4415.403920470743, 4430.003249268921, 4474.664400169984, 4503.527129651388, 4249.3413520904305, 4384.276594361926, 4400.801963911632, 4407.955920440802, 4502.144592527409, 4302.612764851147, 4308.612224899774, 4372.868813935587, 4378.343248512717, 4381.978090109529, 4308.375285583573, 4329.696921215516, 4381.693281470299, 4390.626796722282, 4398.076403955173, 4685.484596694361, 4702.27114797207, 4725.196716558194, 4735.526447355272, 4782.928256076161, 4891.8287859925085, 5052.722100284483, 5055.469175736532, 5056.873578160576, 5101.336826212606, 4945.2829339745895, 5006.874828129326, 5079.339685840854, 5081.187010078406, 5152.974235128838, 4739.218029025206, 4748.715077095385, 4749.026449577828, 4753.33453316536, 4807.423109226846, 5187.922181167285, 5188.11801993662, 5192.45479224676, 5195.272661827347, 5253.264542963988, 4801.735904525215, 4853.684510506806, 4950.925736113961, 4954.826581069645, 4986.850394488171, 5099.974500127476, 5103.260027296022, 5103.87240318995, 5107.33604631403, 5163.97418012915, 5032.521910418578, 5067.037262920034, 5067.315912351859, 5118.692878427306, 5135.281060651511, 4848.296996935424, 4919.0899683558655, 4922.310876477296, 5014.874628134253, 5047.545720885138, 4235.385869048971, 4252.064545799919, 4255.744655320691, 4258.8296468140925, 4263.339182426729, 3723.0320116769835, 3770.0763312988493, 3776.584575696671, 3795.3927371620407, 3818.6372294631965, 4281.614654681093, 4283.7001409901, 4284.614384705392, 4324.827006919688, 4335.34969754533, 4912.336834527365, 5074.264231686385, 5075.746212689351, 5075.974620126875, 5082.695038297714, 4157.272477316457, 4195.223883581547, 4241.893952651147, 4248.065425606362, 4297.871063868089, 4520.389747384061, 4523.570260825217, 4531.932021019687, 4539.228331183706, 4555.339475775994, 4714.245720684674, 4750.7862146202815, 4760.262159365304, 4761.357216775691, 4819.445763737145, 4882.95117048825, 4930.753462326941, 5020.3724534433195, 5057.165567681292, 5067.341245638044, 4775.307580400753, 4775.6179505638775, 4776.641751868554, 4804.615630749601, 4828.275758636232, 4918.360613120271, 4921.089598424303, 4923.704577725348, 4951.653384263067, 4981.302617633607, 4897.485763994871, 4951.851444456672, 4993.775280112331, 4995.750212489288, 5037.19404895215, 4973.651844371004, 4974.204127339608, 4978.775955082103, 5028.220625803006, 5040.798368065236, 4951.480094590016, 4960.553550180501, 4961.0, 4963.379577552806, 5027.044861476308, 4752.786124624331, 4805.9038819224115, 4843.2250839865455, 4894.094592500399, 4962.602991760578, 4921.557059864629, 4988.376452943382, 5005.074061298671, 5052.873678158076, 5053.0, 4669.136209801198, 4883.096627123993, 4897.2654101885, 4905.068037072945, 4934.210526315772], "value": 4636.278020767404, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.6626523483761, 582.947534721875, 591.5031373646136, 591.9585629005971, 594.7056207177446, 27976.30059248517, 38578.421323680166, 40047.99880003005, 40095.39856902149, 43806.0, 40348.19303613926, 40454.0, 40707.79646101773, 40711.38932916008, 40770.18459630813, 7258.0, 7552.131504876941, 7701.152873183945, 7707.6916923323, 7708.768736937901, 7144.464165187632, 9777.217822574177, 10033.147182489498, 10046.497675116252, 10369.585216591327, 10012.199024078056, 10118.645847395343, 10119.645812396568, 10123.544440500158, 10127.442990635513, 9866.112049915506, 9950.30347875649, 9955.402675839472, 9959.103680668775, 9964.202863770917, 9722.173615242713, 9784.51077446132, 9801.852972205423, 9828.0, 9832.803343933152, 35897.82051089754, 36124.0, 36177.27645447076, 36184.63815361839, 36211.4568281476, 2988.2977500287416, 3021.3957208558377, 3477.3914564951033, 3481.89554313371, 3482.512448257246, 27598.310042248904, 28288.717112828814, 28319.17691111715, 28404.573931391045, 28494.287642809097, 3380.7802492837886, 3499.160201551609, 3556.288742251534, 3578.4453409721536, 3601.8019008954498, 245659.0, 245993.7700311505, 246124.0, 246908.0, 248950.0, 31497.8425107873, 49367.753161233966, 49649.50350496521, 49860.25209621859, 49870.501294986585, 31852.681473185436, 33748.325033499685, 33749.49375759366, 33769.83115084409, 33772.32455350879, 11764.294142351486, 11834.763304733857, 11906.583269585522, 12001.519939202508, 12021.699457513458, 8885.733427997171, 9081.45511269326, 9289.953550232205, 9529.809403811885, 9590.904090959, 7566.924330756732, 7587.58268295238, 7770.494917830436, 7788.0, 7834.216578342234, 3095.65339077502, 3104.4101620691995, 3115.8753649854207, 3117.5323701444513, 3161.636411812625, 824.6330382979636, 926.3145272498302, 946.5172761891484, 967.4437198610827, 971.9416834989923, 27335.45329093407, 27993.0, 28270.858645707052, 28350.432991340058, 28488.85755571209, 934.9579268932914, 956.3496822160859, 974.6004138303261, 987.4420952162149, 992.0377234082928, 13751.518696845562, 14493.92753036249, 14645.121292722471, 14793.482228121964, 14903.329350179269, 373044.0, 377031.0, 377145.0, 377215.0, 377512.0, 46403.0, 46681.29978050332, 46793.53206467892, 46914.53085469102, 46931.53068469271, 1081.7403823082561, 1103.4648195625275, 1144.9771004580027, 1186.0985650905375, 1206.324458303353, 26609.0, 27882.721172788013, 27967.58048629313, 28743.425131497672, 28868.278293042003, 39926.80036599799, 40679.38980915348, 40687.1862562753, 40722.0, 40742.38886416647, 299221.0, 301158.0, 301233.0, 301719.0, 302066.0, 24382.51234975326, 24617.753822461545, 25154.874225628755, 25481.87259063693, 26414.735852641996, 40059.59940400559, 40303.798481007405, 40390.79804601076, 40493.1901361977, 41565.79217103895, 35462.82268588641, 35484.29031419409, 35768.64231357653, 35825.596568325964, 36058.27883442369, 34989.0, 35190.824045879606, 35343.646563534036, 35371.0, 35670.0, 34695.306093878484, 34975.0, 35163.64836351604, 35357.116072098404, 35852.462213067345, 30595.847020764755, 33015.17462063371, 33080.33839323248, 33158.33683326368, 33342.0, 24619.63070553979, 24987.250382488553, 25101.0, 25245.67418786474, 25388.365290867878], "value": 16529.587794497136, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.1030386506819, 369.64329422107676, 371.3835033843819, 374.567374682242, 398.49391273083165, 12348.691282717926, 15846.683066338666, 16026.83973160268, 16830.24263908124, 17538.210780514877, 16344.75482867758, 16663.083530405824, 17007.744883826752, 17197.570060748487, 17200.483985480423, 4924.113659541299, 4992.301077849104, 5012.122878496267, 5027.321311622921, 5030.0, 3664.248828990064, 3847.7883716395586, 4976.950230497703, 5067.797288108472, 5071.264666623338, 3811.2568049230413, 3848.7113466489986, 3872.0900588361715, 3874.7093967952374, 3875.050612599917, 5878.118282257653, 6017.578769486116, 6021.879562408771, 6026.186464827236, 6027.7287522061615, 5145.272107655543, 5288.074586947308, 5301.602379821529, 5308.575313974873, 5315.760790764425, 20691.5861682767, 20814.895925520275, 20864.895675521526, 20887.37337879866, 20986.790132098635, 1916.7795703493998, 1928.4793105861338, 2045.263705066175, 2241.4732537853756, 2254.661800729887, 12757.9587266037, 13236.13965092266, 13355.532556360578, 13399.330033498287, 13982.510612128526, 1703.1399143432486, 1710.2133018811362, 1737.4527023987403, 1754.429810311654, 1832.7342535332436, 47219.0, 64232.35767642357, 65173.674131629516, 65937.67031164862, 71813.28186718118, 9412.811743765224, 9697.321187516805, 9710.70867873965, 9824.803503930025, 10035.79928401428, 13436.865631343757, 13450.12574182675, 13457.932710336581, 13468.595942121752, 13486.527971520949, 6973.442124630017, 7163.176234732969, 7173.246809084971, 7298.416126709851, 7305.89041164383, 6656.70044847983, 6706.798796036127, 6732.596044237362, 6892.448604111759, 6892.793216203522, 6159.938400616026, 6178.969105154535, 6205.348438413902, 6206.224221972254, 6217.347178546278, 1784.1881943715578, 1799.4061959553317, 1816.9273229070955, 1829.6980998135425, 1852.5924296654714, 850.4599579267086, 858.9656413743505, 869.5261082709939, 910.0626354854511, 949.1125797379334, 16867.156642167844, 17316.567085822702, 17875.553111172325, 17902.46292611224, 18160.636787264182, 870.6256309786852, 877.8858748362672, 887.8313120507212, 894.8970868350093, 905.8686490458979, 9277.396969196981, 9495.810083798286, 10280.845787313196, 10355.0, 10667.83998240027, 401151.0, 401721.0, 402355.0, 403037.0, 406321.0, 76244.0, 79354.6032269835, 80450.0, 82060.0, 82565.17434825575, 951.0917074194128, 962.2879069488667, 966.9951650241704, 1001.0740065439585, 1002.834532302162, 14796.63008424798, 15855.841441585437, 15863.603409914844, 15986.840131598536, 16944.40694575684, 33071.834640827605, 33934.83032584821, 36610.26779464449, 37742.8112859434, 38957.6104238954, 48732.269015965496, 49316.50683493119, 49485.50514494809, 49806.50193498019, 50709.74645126751, 7539.170691224071, 7594.696212151452, 7773.222677732181, 7941.411717656376, 8246.752597421846, 9092.636294548409, 11932.22440541362, 12119.939400302943, 12309.0, 12892.935535322264, 9433.858492122761, 9989.100980911753, 10592.841107383241, 10752.569897204025, 10922.453877305945, 9460.148586627236, 9894.356866803635, 10801.567937282422, 11029.889701103208, 11033.779324413626, 10883.727906802076, 10951.45242737876, 11012.889871101186, 11131.443427828413, 11500.82748758786, 7908.52548847071, 8010.91989080125, 8072.59637018135, 8146.389020823581, 8203.097659257357, 9136.360454768368, 10208.336458130198, 10599.470026498799, 10870.0, 11371.715707107058], "value": 8336.305016107128, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1101.1741194104422, 1354.9864501354987, 1392.6727219103511, 1464.3776395032116, 1696.4401747423344, 6716.126903502544, 7555.168931417546, 7860.056793184812, 7891.289783919446, 8050.677972881078, 7824.569648669335, 7895.64469598868, 7903.881441778363, 7907.4069444791585, 7907.841843163148, 2230.944226394341, 2245.955080898381, 2246.70792796937, 2247.179779380531, 2251.88740562972, 2187.2016713899393, 2229.6766968789516, 2240.6975058367075, 2244.394013616323, 2247.8763667998255, 2187.2344679362254, 2198.5822693688147, 2203.394066631673, 2206.735191776989, 2251.234580242717, 2174.097749433983, 2192.550527141932, 2193.1775584155944, 2196.5826492966366, 2203.4050806282376, 2159.298228075866, 2162.0919213930188, 2163.5132095278436, 2165.794249546306, 2166.1876796201423, 7658.463907526475, 7737.0, 7880.0937892142565, 7883.369330453607, 7894.368450523944, 4421.535738747418, 4612.815487380501, 4616.746078965655, 4621.953780462186, 4624.907501849978, 2826.23691603266, 2918.3871387008753, 2951.3064429858964, 2958.9408211835644, 2967.4806908790874, 1006.7936073105069, 1025.5795123999123, 1028.7788125553043, 1061.0821639281965, 1073.3613499967507, 10095.0, 10501.264911456125, 10512.264141510097, 10574.52414641343, 10878.564857405694, 4022.336314508132, 4115.115250221157, 4210.831566737357, 4236.046889449849, 4245.511766146871, 8414.158584141536, 8419.284360829399, 8428.072911979678, 8429.957850210709, 8432.198941100585, 4488.438945131858, 4499.212637788374, 4499.257622492252, 4503.797329120198, 4506.549345065533, 3615.439606860941, 3640.3447379471418, 3734.215814678948, 4178.8537401190815, 4179.770112643834, 3498.1954150545516, 3533.5229743984746, 3550.0769799852224, 3564.518789963322, 3565.6969157621893, 1007.2495990487134, 1044.8454457824148, 1060.6870973062964, 1063.0698139128262, 1073.5920350267004, 686.2485578291762, 703.869784089945, 732.9230430804795, 760.3802900635964, 783.7766236622535, 4866.31871537985, 4922.335484709519, 5151.922721159186, 5160.354955630546, 5207.661502002434, 824.3611201318906, 878.5519385113638, 897.3180382908905, 907.587047893207, 908.9045650206765, 3192.664770199142, 3225.935481290361, 3281.8030918144987, 3312.93374132516, 3484.651534846495, 9244.260459163252, 9689.176420004378, 9777.804443911082, 9779.559919803625, 9809.313348065709, 9552.092551207625, 9724.75688107803, 9736.269779766404, 9737.07497787709, 9837.360571562825, 7329.230430804795, 7470.36501897334, 7474.85050298991, 7475.2151024141685, 7490.588017658972, 4532.864014079583, 4627.120847039052, 4662.300654901792, 5264.289320941624, 5393.8112166074, 8962.193402593797, 9121.680741174026, 9137.177654010906, 9139.497327647043, 9232.0, 8965.865512017195, 9211.447313161232, 9221.49281789508, 9254.583543740682, 9312.255019598551, 6772.05191273232, 6882.8623427530165, 6911.447084233148, 6920.411765000032, 6926.480513961373, 6283.277423096402, 6560.475161986934, 7281.19906810261, 7535.397168226419, 7670.501417408074, 6675.365840245169, 6720.798376048726, 6798.7280508779095, 6829.487788415988, 6980.232174460907, 6517.055027020961, 6521.771737989147, 6611.834704132435, 6648.0, 6694.230163531256, 5879.5002424794375, 5947.940520594739, 5956.076808094752, 5968.343482217039, 5971.253593300838, 4422.601965823092, 4430.756308403069, 4439.4006809080365, 4475.267862929959, 4484.798184081659, 4438.289873620205, 4486.820527178877, 4492.483364413004, 4515.390422292949, 4547.272436410159], "value": 4075.695601126519, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.7170716112532, 296.47819837086735, 297.54475652252063, 303.6492850757375, 312.1276033486406, 4832.695172303476, 4846.2972868934075, 4858.688154198364, 4880.438749543803, 4883.0, 4772.90454190916, 4808.783604737787, 4825.6622036457375, 4829.382156977408, 4837.153498137829, 3617.2584620152807, 3727.850885964558, 3730.235301763132, 3821.948964034899, 3827.1962887793597, 3827.406751953438, 3833.731638785286, 3835.6931445484433, 3836.731428799985, 3846.7114966377494, 3792.3363411403034, 3796.4874741909903, 3810.5427348718054, 3815.809209539512, 3822.789746563938, 3637.3816451203224, 3710.7959062251566, 3746.2694774518845, 3795.2788970095594, 3808.6762625176893, 3363.495475678668, 3374.9662503375143, 3377.4764911438765, 3380.154961259685, 3382.0868365541414, 4715.31627913954, 4740.07568524138, 4748.335233067373, 4749.121412538691, 4756.28655701644, 4207.347861081537, 4337.913241735179, 4355.063661312833, 4370.8033138508845, 4372.256716358227, 4980.576650984671, 5004.449510553836, 5023.965294055914, 5028.4971502849785, 5039.168537191359, 3701.1117331840433, 3703.1112532992156, 3717.665410113103, 3719.925601487982, 3726.5341832270965, 5169.508896654812, 5249.763760630781, 5267.157254839208, 5300.761465734013, 5343.625946183769, 3711.6102809205186, 3746.089494357843, 3750.249950010009, 3761.5486141663177, 3768.246350729865, 3809.8857034289017, 3811.4282857571584, 3816.8473261069803, 3819.2170605025904, 3819.751716138442, 4307.138572285556, 4309.396684464177, 4320.243957307459, 4322.740635561876, 4324.070324880166, 4815.566599006036, 4983.700977941335, 5020.974895125574, 5027.723475208899, 5048.6718363307, 1307.3659275251496, 1318.228836130855, 1323.4904561743797, 1323.503686117706, 1326.8208791813174, 832.4589017138908, 859.5186695450568, 865.1435079271475, 879.7404765594165, 883.5008220355479, 4183.0, 4220.472440944882, 4331.198728235287, 4331.263685173528, 4338.717983331074, 5133.666311689728, 5155.74221288934, 5161.509656582619, 5163.302954101148, 5206.479352064764, 4351.456067991501, 4356.190257284097, 4359.782010899506, 4366.410534577855, 4414.911701765946, 2615.738426157407, 2735.3435175557725, 2737.86310684465, 2755.5040092783092, 2762.1713485954133, 4888.242322440027, 4897.41231052276, 4909.275352179575, 4927.679700819435, 4945.9366236259375, 5071.39143302806, 5282.102042652758, 5299.258103865462, 5328.307320048369, 5328.387235467893, 4867.561919427198, 4905.533974272438, 4920.138975679313, 4921.458639549575, 4925.655204135676, 5187.066328060985, 5204.531592156724, 5230.607704422107, 5232.790688372423, 5246.186841039645, 4950.282209079592, 5096.439391666988, 5097.617678674188, 5098.7705553250935, 5119.158866828946, 4868.099401610713, 4897.877553061059, 4899.265110233494, 4903.298010002425, 4908.460069392436, 3780.5822816443833, 3793.4689143519377, 3800.201957588937, 3804.505414296124, 3816.3702989007616, 4981.0, 5185.870353241199, 5205.323307969939, 5215.965773348321, 5247.921281180709, 4950.529699678525, 4986.750662466789, 4988.55103040728, 5002.199208284942, 5033.974830125826, 4958.826441074545, 4978.701277923336, 4980.477049909708, 5019.719971407268, 5030.949690503048, 4735.129623798649, 4918.901621967612, 4930.852074437773, 4976.900461990812, 4986.276989836526, 4883.706977581356, 4896.853094407174, 5010.169254371269, 5095.898082038412, 5116.411612664591, 4927.359443272351, 4935.580475659465, 4950.381202349707, 4986.376702912136, 4992.975035124947], "value": 3818.436149454015, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [613.2242712968094, 643.0932385336677, 653.6764301670673, 715.7459102018784, 716.9103862017248, 12842.293673847946, 14370.20963846988, 14375.424983000667, 14384.784228236558, 14388.496402625897, 12967.935160324185, 13010.73978520429, 13028.218306901592, 13031.087823852335, 13110.475580976774, 606.0999415867433, 620.6059152438189, 736.0394684936156, 736.694271877173, 749.134749364485, 759.7758661194961, 760.0157795654641, 760.9505382150143, 761.6496411650647, 762.2073044034198, 799.1968072087544, 800.4756884240832, 800.4796882026671, 800.8878756974028, 800.9439339246255, 635.0949896397638, 649.422014407178, 770.9575973321465, 794.3406972213107, 800.1438460846896, 593.4718100890211, 594.2542109652402, 594.316535983618, 594.4174708785371, 594.4768603628822, 13192.406341714646, 13208.33958302081, 13239.20564766117, 13243.668908277274, 13254.40355184019, 12391.442385092692, 12424.627261182179, 12527.874721252761, 13030.218186908722, 13335.666608334772, 11419.429028548539, 11465.197436179471, 11573.652790416301, 11810.409479526075, 12151.696207594792, 3976.6619837313865, 3992.1017771001584, 4106.080387486423, 4142.730722503058, 4234.767087810169, 62802.0, 63004.36995630077, 63224.683876580784, 64233.67883160601, 64265.67867160681, 10005.44970026641, 10119.139873110867, 10318.690439286833, 10610.416427096583, 10626.468676566295, 19479.513012174524, 19491.707624385646, 19565.51086222856, 19575.510612234808, 20461.18155273802, 6624.768133115318, 6627.237867645186, 6684.498662600325, 6722.0, 6746.932530674729, 3525.9118522036642, 3533.3463309287863, 3549.148204430918, 3553.2538166984705, 3554.2180720241504, 2788.9721102789117, 2925.8683359248885, 2927.209653393572, 2928.443595716807, 2929.150546341537, 458.1478450082843, 529.8675331167208, 542.0459990416895, 545.6562365709657, 559.5970900951309, 380.8990617486368, 504.7123139810273, 505.79262502374587, 521.291044179915, 522.1254398881857, 7327.670254838545, 7895.723649672349, 8073.555954422446, 8075.0, 8169.5506747129475, 461.4140042146455, 464.05796233645754, 512.8615273876107, 516.6770768269831, 524.5881982643607, 3563.590187128513, 3751.4560388744026, 3790.5830358660523, 3852.5954774748247, 3973.0663294125857, 59752.70123649441, 59914.70042649759, 60333.39666603278, 60501.69749151226, 104243.4787826056, 67535.66232168808, 89593.10406895979, 91859.0, 92916.0, 95013.5249323749, 49560.0, 55162.448375516535, 78078.60960695274, 79652.20347796564, 80224.0, 6458.192725909262, 6926.757563485254, 6927.272636373108, 6940.618265995418, 7241.312075352833, 42214.57785422107, 42714.0, 43275.35086973635, 45178.54821451743, 45388.773056135826, 54171.0, 59261.70369148126, 59858.40141598703, 60406.697966509884, 60862.0, 8898.644054237759, 9064.138906803842, 9125.77185570366, 9161.175494205287, 9204.907950920406, 9400.764980875532, 9590.712278631652, 9636.373635713657, 9732.41605503672, 9911.603535858485, 9650.324477286804, 9767.853482197916, 10516.894831051592, 10761.30051546647, 10808.351498910091, 9837.262205334771, 10043.899561004297, 10378.325408848401, 10775.245732798629, 10780.892191077988, 9622.085901839315, 9840.931920061317, 9850.211983041483, 9887.555060022172, 9909.355891867006, 7533.886991695019, 7590.39276857839, 7706.0, 7855.293023627901, 8029.959850200712, 7708.152103268748, 8071.23323284287, 8240.0, 8284.08875023759, 8349.624266907882], "value": 6157.503763232849, "unit": "score"}], "name": "dromaeo_css", "value": 6278.040898211508, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 115.0, 116.0, 115.0, 115.0, 114.0, 114.0, 113.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 128.0, 127.0, 174.0, 126.0, 123.0, 124.0, 121.0, 156.0, 125.0], "value": 135.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 161.0, 160.0, 163.0, 163.0, 164.0, 163.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 108.0, 77.0, 77.0, 77.0, 77.0, 109.0, 76.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 112.0, 84.0, 84.0, 84.0, 116.0, 84.0, 83.0, 113.0], "value": 93.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 118.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 76.0, 62.0, 63.0, 63.0, 65.0, 65.0, 63.0, 63.0, 64.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 65.0, 66.0, 66.0, 66.0, 67.0, 65.0, 66.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 83.0, 83.0, 83.0, 82.0, 85.0, 81.0, 83.0, 82.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 134.0, 141.0, 134.0, 139.0, 135.0, 135.0, 132.0, 186.0, 144.0], "value": 142.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 173.0, 176.0, 176.0, 176.0, 181.0, 174.0, 181.0, 176.0, 175.0], "value": 176.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 69.0, 69.0, 68.0, 69.0, 69.0, 68.0, 69.0, 68.0], "value": 68.8, "unit": "score"}], "name": "kraken", "value": 1548.5, "alertThreshold": 2.0}]} 22:42:54 INFO - Return code: 0 22:42:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:42:54 INFO - # TBPL SUCCESS # 22:42:54 INFO - Running post-action listener: _resource_record_post_action 22:42:54 INFO - [mozharness: 2016-09-18 05:42:54.593402Z] Finished run-tests step (success) 22:42:54 INFO - Running post-run listener: _resource_record_post_run 22:42:54 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 384409600; Read time: 16; Write time: 326000 22:42:54 INFO - TinderboxPrint: CPU usage
13.1% 22:42:54 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 22:42:54 INFO - TinderboxPrint: I/O write bytes / time
384,409,600 / 326,000 22:42:54 INFO - TinderboxPrint: CPU idle
8,342.3 (86.9%) 22:42:54 INFO - TinderboxPrint: CPU user
1,203.2 (12.5%) 22:42:54 INFO - TinderboxPrint: Swap in / out
0 / 0 22:42:54 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99688448; Read time: 0; Write time: 86396 22:42:54 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 284721152; Read time: 0; Write time: 239604 22:42:55 INFO - Running post-run listener: _upload_blobber_files 22:42:55 INFO - Blob upload gear active. 22:42:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:42:55 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:42:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:42:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:42:55 INFO - (blobuploader) - INFO - Open directory for files ... 22:42:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:42:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:42:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:42:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:42:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:42:56 INFO - (blobuploader) - INFO - Done attempting. 22:42:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:42:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:42:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:42:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:42:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:42:59 INFO - (blobuploader) - INFO - Done attempting. 22:42:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:42:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:42:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:43:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:43:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:43:00 INFO - (blobuploader) - INFO - Done attempting. 22:43:00 INFO - (blobuploader) - INFO - Iteration through files over. 22:43:00 INFO - Return code: 0 22:43:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:43:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:43:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/361f621fe206ea473c0d4a0141bd9a366ca606a3cdcb1bd62a0520d2a697e5a7e88c3a1b974ba88a9fe2b8372019074f1c1b05d8cb9801ba47ab210f76667a49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/761da60e9b35fa06949b9482be17ce1125bd2b45c700aeed2ecea01a134df3d158e8c7e2d51b66949bf4120a1531550173e201a318353fa8f315a0e9c6ecd350", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d26e29a593d396ed8e1b89dfb89abc6192e5bb19c366cf2b85123463e0563d05be196ceda079c0d43741993c4030e6d487cc74f71af802550f1d799e76220fd9"} 22:43:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:43:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:43:00 INFO - Contents: 22:43:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/361f621fe206ea473c0d4a0141bd9a366ca606a3cdcb1bd62a0520d2a697e5a7e88c3a1b974ba88a9fe2b8372019074f1c1b05d8cb9801ba47ab210f76667a49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/761da60e9b35fa06949b9482be17ce1125bd2b45c700aeed2ecea01a134df3d158e8c7e2d51b66949bf4120a1531550173e201a318353fa8f315a0e9c6ecd350", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d26e29a593d396ed8e1b89dfb89abc6192e5bb19c366cf2b85123463e0563d05be196ceda079c0d43741993c4030e6d487cc74f71af802550f1d799e76220fd9"} 22:43:00 INFO - Running post-run listener: copy_logs_to_upload_dir 22:43:00 INFO - Copying logs to upload dir... 22:43:00 INFO - mkdir: /builds/slave/test/build/upload/logs 22:43:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.178010 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-09-17 22:42:59.815677) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-17 22:42:59.819138) ========= 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=cbe409c6de289db6ac707de3000001d4-1474166449.127614-1672681899 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/361f621fe206ea473c0d4a0141bd9a366ca606a3cdcb1bd62a0520d2a697e5a7e88c3a1b974ba88a9fe2b8372019074f1c1b05d8cb9801ba47ab210f76667a49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/761da60e9b35fa06949b9482be17ce1125bd2b45c700aeed2ecea01a134df3d158e8c7e2d51b66949bf4120a1531550173e201a318353fa8f315a0e9c6ecd350", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d26e29a593d396ed8e1b89dfb89abc6192e5bb19c366cf2b85123463e0563d05be196ceda079c0d43741993c4030e6d487cc74f71af802550f1d799e76220fd9"} build_url:https://queue.taskcluster.net/v1/task/Mut_I0gdQL-ddjjWnD5Hjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011322 build_url: 'https://queue.taskcluster.net/v1/task/Mut_I0gdQL-ddjjWnD5Hjw/artifacts/public/build/firefox-51.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/361f621fe206ea473c0d4a0141bd9a366ca606a3cdcb1bd62a0520d2a697e5a7e88c3a1b974ba88a9fe2b8372019074f1c1b05d8cb9801ba47ab210f76667a49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/761da60e9b35fa06949b9482be17ce1125bd2b45c700aeed2ecea01a134df3d158e8c7e2d51b66949bf4120a1531550173e201a318353fa8f315a0e9c6ecd350", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d26e29a593d396ed8e1b89dfb89abc6192e5bb19c366cf2b85123463e0563d05be196ceda079c0d43741993c4030e6d487cc74f71af802550f1d799e76220fd9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-17 22:42:59.847568) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 22:42:59.848399) ========= 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=cbe409c6de289db6ac707de3000001d4-1474166449.127614-1672681899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004530 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 22:42:59.932803) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-17 22:42:59.933451) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-17 22:42:59.934029) ========= ========= Total master_lag: 0.18 =========