builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-053 starttime: 1474151583.85 results: success (0) buildid: 20160917140433 builduid: fb1cb88a62b748759cf5dc45dae5a3ad revision: eaf5eb6f8fa0d8e7a09f3774c0da53c0dd6dadd7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-17 15:33:03.851404) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-17 15:33:03.851869) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-17 15:33:03.852150) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-17 15:33:03.867418) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 15:33:03.867822) ========= 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=920470bf432669ad7e3a5387000001ca-1474151583.365078-923415544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-17 15:33:04-- 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% 224M=0s 2016-09-17 15:33:04 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.145085 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 15:33:04.026654) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 15:33:04.027006) ========= 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=920470bf432669ad7e3a5387000001ca-1474151583.365078-923415544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019918 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 15:33:04.077079) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-17 15:33:04.077456) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev eaf5eb6f8fa0d8e7a09f3774c0da53c0dd6dadd7 --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 eaf5eb6f8fa0d8e7a09f3774c0da53c0dd6dadd7 --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=920470bf432669ad7e3a5387000001ca-1474151583.365078-923415544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-17 15:33:04,484 truncating revision to first 12 chars 2016-09-17 15:33:04,484 Setting DEBUG logging. 2016-09-17 15:33:04,484 attempt 1/10 2016-09-17 15:33:04,484 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/eaf5eb6f8fa0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-17 15:33:05,629 unpacking tar archive at: fx-team-eaf5eb6f8fa0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.473000 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-17 15:33:05.564295) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-17 15:33:05.564622) ========= script_repo_revision: eaf5eb6f8fa0d8e7a09f3774c0da53c0dd6dadd7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-17 15:33:05.565026) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-17 15:33:05.565291) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-17 15:33:05.574873) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-09-17 15:33:05.575191) ========= /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=920470bf432669ad7e3a5387000001ca-1474151583.365078-923415544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:33:06 INFO - MultiFileLogger online at 20160917 15:33:06 in /builds/slave/test 15:33:06 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 15:33:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:33:06 INFO - {'append_to_log': False, 15:33:06 INFO - 'base_work_dir': '/builds/slave/test', 15:33:06 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:33:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:33:06 INFO - 'branch': 'Fx-Team-Non-PGO', 15:33:06 INFO - 'buildbot_json_path': 'buildprops.json', 15:33:06 INFO - 'config_files': ('talos/linux_config.py',), 15:33:06 INFO - 'default_actions': ('clobber', 15:33:06 INFO - 'read-buildbot-config', 15:33:06 INFO - 'download-and-extract', 15:33:06 INFO - 'populate-webroot', 15:33:06 INFO - 'create-virtualenv', 15:33:06 INFO - 'install', 15:33:06 INFO - 'run-tests'), 15:33:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:33:06 INFO - 'download_minidump_stackwalk': True, 15:33:06 INFO - 'download_symbols': 'ondemand', 15:33:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:33:06 INFO - 'tooltool.py': '/tools/tooltool.py', 15:33:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:33:06 INFO - '/tools/misc-python/virtualenv.py')}, 15:33:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:33:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:33:06 INFO - 'installer_path': 'installer.exe', 15:33:06 INFO - 'log_level': 'info', 15:33:06 INFO - 'log_name': 'talos', 15:33:06 INFO - 'log_to_console': True, 15:33:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:33:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:33:06 INFO - 'opt_config_files': (), 15:33:06 INFO - 'pip_index': False, 15:33:06 INFO - 'sps_profile': False, 15:33:06 INFO - 'sps_profile_interval': 0, 15:33:06 INFO - 'suite': 'dromaeojs', 15:33:06 INFO - 'system_bits': '32', 15:33:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:33:06 INFO - 'title': 'talos-linux64-ix-053', 15:33:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:33:06 INFO - 'use_talos_json': True, 15:33:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:33:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:33:06 INFO - 'work_dir': 'build'} 15:33:06 INFO - [mozharness: 2016-09-17 22:33:06.076443Z] Running clobber step. 15:33:06 INFO - Running pre-action listener: _resource_record_pre_action 15:33:06 INFO - Running main action method: clobber 15:33:06 INFO - rmtree: /builds/slave/test/build 15:33:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:33:06 INFO - Running post-action listener: _resource_record_post_action 15:33:06 INFO - [mozharness: 2016-09-17 22:33:06.538937Z] Finished clobber step (success) 15:33:06 INFO - [mozharness: 2016-09-17 22:33:06.539037Z] Running read-buildbot-config step. 15:33:06 INFO - Running pre-action listener: _resource_record_pre_action 15:33:06 INFO - Running main action method: read_buildbot_config 15:33:06 INFO - Using buildbot properties: 15:33:06 INFO - { 15:33:06 INFO - "project": "", 15:33:06 INFO - "product": "firefox", 15:33:06 INFO - "script_repo_revision": "production", 15:33:06 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:33:06 INFO - "repository": "", 15:33:06 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:33:06 INFO - "buildid": "20160917140433", 15:33:06 INFO - "pgo_build": "False", 15:33:06 INFO - "basedir": "/builds/slave/test", 15:33:06 INFO - "buildnumber": 3326, 15:33:06 INFO - "slavename": "talos-linux64-ix-053", 15:33:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:33:06 INFO - "platform": "ubuntu64_hw", 15:33:06 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:33:06 INFO - "branch": "fx-team", 15:33:06 INFO - "repo_path": "integration/fx-team", 15:33:06 INFO - "revision": "eaf5eb6f8fa0d8e7a09f3774c0da53c0dd6dadd7", 15:33:06 INFO - "stage_platform": "linux64", 15:33:06 INFO - "builduid": "fb1cb88a62b748759cf5dc45dae5a3ad", 15:33:06 INFO - "slavebuilddir": "test" 15:33:06 INFO - } 15:33:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/AwgkQsfLSCe89EXhAwZE3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 15:33:06 INFO - Running post-action listener: _resource_record_post_action 15:33:06 INFO - [mozharness: 2016-09-17 22:33:06.541491Z] Finished read-buildbot-config step (success) 15:33:06 INFO - [mozharness: 2016-09-17 22:33:06.541582Z] Running download-and-extract step. 15:33:06 INFO - Running pre-action listener: _resource_record_pre_action 15:33:06 INFO - Running main action method: download_and_extract 15:33:06 INFO - mkdir: /builds/slave/test/build/tests 15:33: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')]} 15:33:06 INFO - trying https://queue.taskcluster.net/v1/task/AwgkQsfLSCe89EXhAwZE3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:33:06 INFO - Downloading https://queue.taskcluster.net/v1/task/AwgkQsfLSCe89EXhAwZE3Q/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 15:33:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AwgkQsfLSCe89EXhAwZE3Q/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 15:33:07 INFO - Downloaded 1361 bytes. 15:33:07 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:33:07 INFO - Using the following test package requirements: 15:33:07 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:33:07 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:33:07 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:33:07 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:33:07 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:33:07 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:33:07 INFO - u'jsshell-linux-x86_64.zip'], 15:33:07 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:33:07 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:33:07 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:33:07 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:33:07 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:33:07 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:33:07 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:33:07 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:33:07 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:33:07 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:33:07 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:33:07 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:33:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AwgkQsfLSCe89EXhAwZE3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:33:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AwgkQsfLSCe89EXhAwZE3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:33:07 INFO - Fetch https://queue.taskcluster.net/v1/task/AwgkQsfLSCe89EXhAwZE3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:33:07 INFO - Expected file size: 20365610 15:33:11 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 15:33:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AwgkQsfLSCe89EXhAwZE3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:33:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AwgkQsfLSCe89EXhAwZE3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:33:11 INFO - Fetch https://queue.taskcluster.net/v1/task/AwgkQsfLSCe89EXhAwZE3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:33:12 INFO - Expected file size: 20365610 15:33:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AwgkQsfLSCe89EXhAwZE3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 15:33:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AwgkQsfLSCe89EXhAwZE3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:33:17 INFO - Fetch https://queue.taskcluster.net/v1/task/AwgkQsfLSCe89EXhAwZE3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:33:17 INFO - Expected file size: 14414048 15:33:18 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')]} 15:33:18 INFO - trying https://queue.taskcluster.net/v1/task/AwgkQsfLSCe89EXhAwZE3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:33:18 INFO - Downloading https://queue.taskcluster.net/v1/task/AwgkQsfLSCe89EXhAwZE3Q/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 15:33:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AwgkQsfLSCe89EXhAwZE3Q/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 15:33:19 INFO - Downloaded 55594561 bytes. 15:33:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AwgkQsfLSCe89EXhAwZE3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:33:19 INFO - mkdir: /builds/slave/test/properties 15:33:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:33:19 INFO - Writing to file /builds/slave/test/properties/build_url 15:33:19 INFO - Contents: 15:33:19 INFO - build_url:https://queue.taskcluster.net/v1/task/AwgkQsfLSCe89EXhAwZE3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:33:19 INFO - Running post-action listener: _resource_record_post_action 15:33:19 INFO - Running post-action listener: set_extra_try_arguments 15:33:19 INFO - [mozharness: 2016-09-17 22:33:19.841800Z] Finished download-and-extract step (success) 15:33:19 INFO - [mozharness: 2016-09-17 22:33:19.842028Z] Running populate-webroot step. 15:33:19 INFO - Running pre-action listener: _resource_record_pre_action 15:33:19 INFO - Running main action method: populate_webroot 15:33:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:33:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:33:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:33:19 INFO - '--tppagecycles', 15:33:19 INFO - '7'], 15:33:19 INFO - 'tests': ['tsvgm']}}, 15:33:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:33:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:33:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:33:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:33:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:33:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:33:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:19 INFO - 'talos_options': ['--disable-e10s'], 15:33:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:33:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:33:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:19 INFO - 'talos_options': ['--disable-e10s'], 15:33:19 INFO - 'tests': ['damp', 'tps']}, 15:33:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:19 INFO - 'tests': ['damp', 'tps']}, 15:33:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:33:19 INFO - 'tests': ['dromaeo_dom']}, 15:33:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:33:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:33:19 INFO - 'tests': ['basic_compositor_video']}, 15:33:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:33:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:33:19 INFO - 'tests': ['a11yr', 15:33:19 INFO - 'ts_paint', 15:33:19 INFO - 'tpaint', 15:33:19 INFO - 'sessionrestore', 15:33:19 INFO - 'sessionrestore_no_auto_restore', 15:33:19 INFO - 'tabpaint']}, 15:33:19 INFO - 'other-e10s': {'tests': ['a11yr', 15:33:19 INFO - 'ts_paint', 15:33:19 INFO - 'tpaint', 15:33:19 INFO - 'sessionrestore', 15:33:19 INFO - 'sessionrestore_no_auto_restore', 15:33:19 INFO - 'tabpaint']}, 15:33:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:33:19 INFO - 'ts_paint', 15:33:19 INFO - 'tpaint', 15:33:19 INFO - 'sessionrestore', 15:33:19 INFO - 'sessionrestore_no_auto_restore', 15:33:19 INFO - 'tabpaint']}, 15:33:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:33:19 INFO - 'ts_paint', 15:33:19 INFO - 'tpaint', 15:33:19 INFO - 'sessionrestore', 15:33:19 INFO - 'sessionrestore_no_auto_restore', 15:33:19 INFO - 'tabpaint']}, 15:33:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:33:19 INFO - 'tests': ['a11yr', 15:33:19 INFO - 'ts_paint', 15:33:19 INFO - 'tpaint', 15:33:19 INFO - 'sessionrestore', 15:33:19 INFO - 'sessionrestore_no_auto_restore', 15:33:19 INFO - 'tabpaint']}, 15:33:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:33:19 INFO - 'tests': ['a11yr', 15:33:19 INFO - 'ts_paint', 15:33:19 INFO - 'tpaint', 15:33:19 INFO - 'sessionrestore', 15:33:19 INFO - 'sessionrestore_no_auto_restore', 15:33:19 INFO - 'tabpaint']}, 15:33:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:33:19 INFO - 'tests': ['tsvgx', 15:33:19 INFO - 'tsvgr_opacity', 15:33:19 INFO - 'tart', 15:33:19 INFO - 'tscrollx', 15:33:19 INFO - 'cart']}, 15:33:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:33:19 INFO - 'tsvgr_opacity', 15:33:19 INFO - 'tart', 15:33:19 INFO - 'tscrollx', 15:33:19 INFO - 'cart']}, 15:33:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:19 INFO - 'talos_options': ['--disable-e10s'], 15:33:19 INFO - 'tests': ['tp5o']}, 15:33:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:19 INFO - 'tests': ['tp5o']}, 15:33:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:19 INFO - 'talos_options': ['--disable-e10s', 15:33:19 INFO - '--xperf_path', 15:33:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:33:19 INFO - 'tests': ['tp5n']}, 15:33:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:19 INFO - 'talos_options': ['--xperf_path', 15:33:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:33:19 INFO - 'tests': ['tp5n']}}, 15:33:19 INFO - 'talos.zip': {'path': '', 15:33:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:33:19 INFO - Running post-action listener: _resource_record_post_action 15:33:19 INFO - [mozharness: 2016-09-17 22:33:19.861337Z] Finished populate-webroot step (success) 15:33:19 INFO - [mozharness: 2016-09-17 22:33:19.861426Z] Running create-virtualenv step. 15:33:19 INFO - Running pre-action listener: _resource_record_pre_action 15:33:19 INFO - Running main action method: create_virtualenv 15:33:19 INFO - Creating virtualenv /builds/slave/test/build/venv 15:33:19 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 15:33:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:33:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:33:19 INFO - Using real prefix '/usr' 15:33:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:33:20 INFO - Installing distribute.............................................................................................................................................................................................done. 15:33:22 INFO - Installing pip.................done. 15:33:22 INFO - Return code: 0 15:33:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:33:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:22 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 0x7f5436ac2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4bf60>, '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 0x2c4cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c4d1d0>, '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': '920470bf432669ad7e3a5387000001ca-1474151583.365078-923415544', '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 15:33:22 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 15:33:22 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 15:33:22 INFO - Using env: {'DISPLAY': ':0', 15:33:22 INFO - 'HOME': '/home/cltbld', 15:33:22 INFO - 'LANG': 'en_US.UTF-8', 15:33:22 INFO - 'LANGUAGE': 'en_US:en', 15:33:22 INFO - 'LOGNAME': 'cltbld', 15:33:22 INFO - 'MAIL': '/var/mail/cltbld', 15:33:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:22 INFO - 'MOZ_NO_REMOTE': '1', 15:33:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:22 INFO - 'NO_EM_RESTART': '1', 15:33:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:22 INFO - 'PWD': '/builds/slave/test', 15:33:22 INFO - 'SHELL': '/bin/bash', 15:33:22 INFO - 'SHLVL': '1', 15:33:22 INFO - 'TERM': 'linux', 15:33:22 INFO - 'TMOUT': '86400', 15:33:22 INFO - 'USER': 'cltbld', 15:33:22 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1474151583.365078-923415544', 15:33:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:22 INFO - '_': '/tools/buildbot/bin/python'} 15:33:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:22 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 15:33:22 INFO - Cleaning up... 15:33:22 INFO - Return code: 0 15:33:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:33:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:22 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 0x7f5436ac2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4bf60>, '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 0x2c4cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c4d1d0>, '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': '920470bf432669ad7e3a5387000001ca-1474151583.365078-923415544', '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 15:33:22 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 15:33:22 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 15:33:22 INFO - Using env: {'DISPLAY': ':0', 15:33:22 INFO - 'HOME': '/home/cltbld', 15:33:22 INFO - 'LANG': 'en_US.UTF-8', 15:33:22 INFO - 'LANGUAGE': 'en_US:en', 15:33:22 INFO - 'LOGNAME': 'cltbld', 15:33:22 INFO - 'MAIL': '/var/mail/cltbld', 15:33:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:22 INFO - 'MOZ_NO_REMOTE': '1', 15:33:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:22 INFO - 'NO_EM_RESTART': '1', 15:33:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:22 INFO - 'PWD': '/builds/slave/test', 15:33:22 INFO - 'SHELL': '/bin/bash', 15:33:22 INFO - 'SHLVL': '1', 15:33:22 INFO - 'TERM': 'linux', 15:33:22 INFO - 'TMOUT': '86400', 15:33:22 INFO - 'USER': 'cltbld', 15:33:22 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1474151583.365078-923415544', 15:33:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:22 INFO - '_': '/tools/buildbot/bin/python'} 15:33:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:22 INFO - Downloading/unpacking psutil>=3.1.1 15:33:22 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 15:33:22 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 15:33:22 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 15:33:22 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 15:33:22 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 15:33:22 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 15:33:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:33:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:33:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:33:24 INFO - Installing collected packages: psutil 15:33:24 INFO - Running setup.py install for psutil 15:33:24 INFO - building 'psutil._psutil_linux' extension 15:33:24 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 15:33:25 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 15:33:25 INFO - building 'psutil._psutil_posix' extension 15:33:25 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 15:33:25 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 15:33:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:33:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:33:25 INFO - Successfully installed psutil 15:33:25 INFO - Cleaning up... 15:33:25 INFO - Return code: 0 15:33:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:33: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')]} 15:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33: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')]} 15:33:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5436ac2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4bf60>, '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 0x2c4cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c4d1d0>, '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': '920470bf432669ad7e3a5387000001ca-1474151583.365078-923415544', '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 15:33:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:33:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:33:25 INFO - Using env: {'DISPLAY': ':0', 15:33:25 INFO - 'HOME': '/home/cltbld', 15:33:25 INFO - 'LANG': 'en_US.UTF-8', 15:33:25 INFO - 'LANGUAGE': 'en_US:en', 15:33:25 INFO - 'LOGNAME': 'cltbld', 15:33:25 INFO - 'MAIL': '/var/mail/cltbld', 15:33:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:25 INFO - 'MOZ_NO_REMOTE': '1', 15:33:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:25 INFO - 'NO_EM_RESTART': '1', 15:33:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:25 INFO - 'PWD': '/builds/slave/test', 15:33:25 INFO - 'SHELL': '/bin/bash', 15:33:25 INFO - 'SHLVL': '1', 15:33:25 INFO - 'TERM': 'linux', 15:33:25 INFO - 'TMOUT': '86400', 15:33:25 INFO - 'USER': 'cltbld', 15:33:25 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1474151583.365078-923415544', 15:33:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:25 INFO - '_': '/tools/buildbot/bin/python'} 15:33:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:33:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:33:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:33:27 INFO - Installing collected packages: mozsystemmonitor 15:33:27 INFO - Running setup.py install for mozsystemmonitor 15:33:27 INFO - Successfully installed mozsystemmonitor 15:33:27 INFO - Cleaning up... 15:33:27 INFO - Return code: 0 15:33:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:33:27 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')]} 15:33:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:27 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')]} 15:33:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:27 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 0x7f5436ac2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4bf60>, '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 0x2c4cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c4d1d0>, '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': '920470bf432669ad7e3a5387000001ca-1474151583.365078-923415544', '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 15:33:27 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 15:33:27 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 15:33:27 INFO - Using env: {'DISPLAY': ':0', 15:33:27 INFO - 'HOME': '/home/cltbld', 15:33:27 INFO - 'LANG': 'en_US.UTF-8', 15:33:27 INFO - 'LANGUAGE': 'en_US:en', 15:33:27 INFO - 'LOGNAME': 'cltbld', 15:33:27 INFO - 'MAIL': '/var/mail/cltbld', 15:33:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:27 INFO - 'MOZ_NO_REMOTE': '1', 15:33:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:27 INFO - 'NO_EM_RESTART': '1', 15:33:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:27 INFO - 'PWD': '/builds/slave/test', 15:33:27 INFO - 'SHELL': '/bin/bash', 15:33:27 INFO - 'SHLVL': '1', 15:33:27 INFO - 'TERM': 'linux', 15:33:27 INFO - 'TMOUT': '86400', 15:33:27 INFO - 'USER': 'cltbld', 15:33:27 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1474151583.365078-923415544', 15:33:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:27 INFO - '_': '/tools/buildbot/bin/python'} 15:33:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:27 INFO - Downloading/unpacking jsonschema==2.5.1 15:33:27 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 15:33:27 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 15:33:27 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 15:33:27 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 15:33:27 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 15:33:27 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 15:33:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:33:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:33:29 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 15:33:29 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 15:33:29 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 15:33:29 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 15:33:29 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 15:33:29 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 15:33:30 INFO - Downloading functools32-3.2.3-2.tar.gz 15:33:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:33:30 INFO - warning: no files found matching '*.txt' 15:33:30 INFO - no previously-included directories found matching 'build' 15:33:30 INFO - no previously-included directories found matching 'dist' 15:33:30 INFO - no previously-included directories found matching '.git*' 15:33:30 INFO - Installing collected packages: jsonschema, functools32 15:33:30 INFO - Running setup.py install for functools32 15:33:30 INFO - warning: no files found matching '*.txt' 15:33:30 INFO - no previously-included directories found matching 'build' 15:33:30 INFO - no previously-included directories found matching 'dist' 15:33:30 INFO - no previously-included directories found matching '.git*' 15:33:30 INFO - Successfully installed jsonschema functools32 15:33:30 INFO - Cleaning up... 15:33:30 INFO - Return code: 0 15:33:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:33:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5436ac2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4bf60>, '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 0x2c4cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c4d1d0>, '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': '920470bf432669ad7e3a5387000001ca-1474151583.365078-923415544', '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 15:33:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:33:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:33:30 INFO - Using env: {'DISPLAY': ':0', 15:33:30 INFO - 'HOME': '/home/cltbld', 15:33:30 INFO - 'LANG': 'en_US.UTF-8', 15:33:30 INFO - 'LANGUAGE': 'en_US:en', 15:33:30 INFO - 'LOGNAME': 'cltbld', 15:33:30 INFO - 'MAIL': '/var/mail/cltbld', 15:33:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:30 INFO - 'MOZ_NO_REMOTE': '1', 15:33:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:30 INFO - 'NO_EM_RESTART': '1', 15:33:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:30 INFO - 'PWD': '/builds/slave/test', 15:33:30 INFO - 'SHELL': '/bin/bash', 15:33:30 INFO - 'SHLVL': '1', 15:33:30 INFO - 'TERM': 'linux', 15:33:30 INFO - 'TMOUT': '86400', 15:33:30 INFO - 'USER': 'cltbld', 15:33:30 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1474151583.365078-923415544', 15:33:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:30 INFO - '_': '/tools/buildbot/bin/python'} 15:33:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:33:30 INFO - Cleaning up... 15:33:30 INFO - Return code: 0 15:33:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:33:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5436ac2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4bf60>, '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 0x2c4cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c4d1d0>, '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': '920470bf432669ad7e3a5387000001ca-1474151583.365078-923415544', '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 15:33:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:33:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:33:30 INFO - Using env: {'DISPLAY': ':0', 15:33:30 INFO - 'HOME': '/home/cltbld', 15:33:30 INFO - 'LANG': 'en_US.UTF-8', 15:33:30 INFO - 'LANGUAGE': 'en_US:en', 15:33:30 INFO - 'LOGNAME': 'cltbld', 15:33:30 INFO - 'MAIL': '/var/mail/cltbld', 15:33:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:30 INFO - 'MOZ_NO_REMOTE': '1', 15:33:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:30 INFO - 'NO_EM_RESTART': '1', 15:33:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:30 INFO - 'PWD': '/builds/slave/test', 15:33:30 INFO - 'SHELL': '/bin/bash', 15:33:30 INFO - 'SHLVL': '1', 15:33:30 INFO - 'TERM': 'linux', 15:33:30 INFO - 'TMOUT': '86400', 15:33:30 INFO - 'USER': 'cltbld', 15:33:30 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1474151583.365078-923415544', 15:33:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:30 INFO - '_': '/tools/buildbot/bin/python'} 15:33:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:30 INFO - Downloading/unpacking blobuploader==1.2.4 15:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:32 INFO - Downloading blobuploader-1.2.4.tar.gz 15:33:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:33:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:33:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:33:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:33 INFO - Downloading docopt-0.6.1.tar.gz 15:33:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:33:33 INFO - Installing collected packages: blobuploader, requests, docopt 15:33:33 INFO - Running setup.py install for blobuploader 15:33:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:33:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:33:33 INFO - Running setup.py install for requests 15:33:33 INFO - Running setup.py install for docopt 15:33:33 INFO - Successfully installed blobuploader requests docopt 15:33:33 INFO - Cleaning up... 15:33:34 INFO - Return code: 0 15:33:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:33: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')]} 15:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33: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')]} 15:33:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:34 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 0x7f5436ac2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4bf60>, '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 0x2c4cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c4d1d0>, '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': '920470bf432669ad7e3a5387000001ca-1474151583.365078-923415544', '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 15:33:34 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 15:33:34 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 15:33:34 INFO - Using env: {'DISPLAY': ':0', 15:33:34 INFO - 'HOME': '/home/cltbld', 15:33:34 INFO - 'LANG': 'en_US.UTF-8', 15:33:34 INFO - 'LANGUAGE': 'en_US:en', 15:33:34 INFO - 'LOGNAME': 'cltbld', 15:33:34 INFO - 'MAIL': '/var/mail/cltbld', 15:33:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:34 INFO - 'MOZ_NO_REMOTE': '1', 15:33:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:34 INFO - 'NO_EM_RESTART': '1', 15:33:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:34 INFO - 'PWD': '/builds/slave/test', 15:33:34 INFO - 'SHELL': '/bin/bash', 15:33:34 INFO - 'SHLVL': '1', 15:33:34 INFO - 'TERM': 'linux', 15:33:34 INFO - 'TMOUT': '86400', 15:33:34 INFO - 'USER': 'cltbld', 15:33:34 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1474151583.365078-923415544', 15:33:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:34 INFO - '_': '/tools/buildbot/bin/python'} 15:33:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:33:34 INFO - Running setup.py (path:/tmp/pip-OFqo7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:33:34 INFO - Running setup.py (path:/tmp/pip-9C2zJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:33:34 INFO - Running setup.py (path:/tmp/pip-oYy85E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:33:34 INFO - Running setup.py (path:/tmp/pip-7RySWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:33:34 INFO - Running setup.py (path:/tmp/pip-bhpVMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:33:34 INFO - Running setup.py (path:/tmp/pip-w6dSpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:33:34 INFO - Running setup.py (path:/tmp/pip-3NlOBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:33:34 INFO - Running setup.py (path:/tmp/pip-V2sLQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:33:34 INFO - Running setup.py (path:/tmp/pip-9Y9r78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:33:34 INFO - Running setup.py (path:/tmp/pip-rgo1yi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:33:34 INFO - Running setup.py (path:/tmp/pip-EHOe46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:33:35 INFO - Running setup.py (path:/tmp/pip-GGR2bb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:33:35 INFO - Running setup.py (path:/tmp/pip-u_FTaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:33:35 INFO - Running setup.py (path:/tmp/pip-WK3TMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:33:35 INFO - Running setup.py (path:/tmp/pip-_pawdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:33:35 INFO - Running setup.py (path:/tmp/pip-YhXhZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:33:35 INFO - Running setup.py (path:/tmp/pip-oCknnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:33:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:33:35 INFO - Running setup.py install for manifestparser 15:33:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:33:35 INFO - Running setup.py install for mozcrash 15:33:35 INFO - Running setup.py install for mozdebug 15:33:35 INFO - Running setup.py install for mozdevice 15:33:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:33:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:33:35 INFO - Running setup.py install for mozfile 15:33:35 INFO - Running setup.py install for mozhttpd 15:33:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:33:36 INFO - Running setup.py install for mozinfo 15:33:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:33:36 INFO - Running setup.py install for mozInstall 15:33:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:33:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:33:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:33:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:33:36 INFO - Running setup.py install for mozleak 15:33:36 INFO - Running setup.py install for mozlog 15:33:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:33:36 INFO - Running setup.py install for moznetwork 15:33:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:33:36 INFO - Running setup.py install for mozprocess 15:33:36 INFO - Running setup.py install for mozprofile 15:33:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:33:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:33:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:33:36 INFO - Running setup.py install for mozrunner 15:33:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:33:36 INFO - Running setup.py install for mozscreenshot 15:33:37 INFO - Running setup.py install for moztest 15:33:37 INFO - Running setup.py install for mozversion 15:33:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:33:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:33:37 INFO - Cleaning up... 15:33:37 INFO - Return code: 0 15:33:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:33:37 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')]} 15:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:37 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')]} 15:33:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:37 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 0x7f5436ac2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4bf60>, '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 0x2c4cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c4d1d0>, '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': '920470bf432669ad7e3a5387000001ca-1474151583.365078-923415544', '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 15:33:37 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 15:33:37 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 15:33:37 INFO - Using env: {'DISPLAY': ':0', 15:33:37 INFO - 'HOME': '/home/cltbld', 15:33:37 INFO - 'LANG': 'en_US.UTF-8', 15:33:37 INFO - 'LANGUAGE': 'en_US:en', 15:33:37 INFO - 'LOGNAME': 'cltbld', 15:33:37 INFO - 'MAIL': '/var/mail/cltbld', 15:33:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:37 INFO - 'MOZ_NO_REMOTE': '1', 15:33:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:37 INFO - 'NO_EM_RESTART': '1', 15:33:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:37 INFO - 'PWD': '/builds/slave/test', 15:33:37 INFO - 'SHELL': '/bin/bash', 15:33:37 INFO - 'SHLVL': '1', 15:33:37 INFO - 'TERM': 'linux', 15:33:37 INFO - 'TMOUT': '86400', 15:33:37 INFO - 'USER': 'cltbld', 15:33:37 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1474151583.365078-923415544', 15:33:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:37 INFO - '_': '/tools/buildbot/bin/python'} 15:33:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:33:37 INFO - Running setup.py (path:/tmp/pip-K8xmKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:33:37 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)) 15:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:33:37 INFO - Running setup.py (path:/tmp/pip-4Ipydf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:33:37 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)) 15:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:33:37 INFO - Running setup.py (path:/tmp/pip-wDTMiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:33:37 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)) 15:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:33:37 INFO - Running setup.py (path:/tmp/pip-Jkuxs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:33:37 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)) 15:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:33:37 INFO - Running setup.py (path:/tmp/pip-JwRpHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:33:37 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)) 15:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:33:37 INFO - Running setup.py (path:/tmp/pip-8hu1mO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:33:37 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)) 15:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:33:37 INFO - Running setup.py (path:/tmp/pip-Derxmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:33:37 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)) 15:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:33:37 INFO - Running setup.py (path:/tmp/pip-5VpxKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:33:38 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)) 15:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:33:38 INFO - Running setup.py (path:/tmp/pip-hjbehI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:33:38 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)) 15:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:33:38 INFO - Running setup.py (path:/tmp/pip-mHu5k9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:33:38 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)) 15:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:33:38 INFO - Running setup.py (path:/tmp/pip-zzNO2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:33:38 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)) 15:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:33:38 INFO - Running setup.py (path:/tmp/pip-1lPxVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:33:38 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)) 15:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:33:38 INFO - Running setup.py (path:/tmp/pip-LylEit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:33:38 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)) 15:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:33:38 INFO - Running setup.py (path:/tmp/pip-A2kH2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:33:38 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)) 15:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:33:38 INFO - Running setup.py (path:/tmp/pip-ciJQDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:33:38 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)) 15:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:33:38 INFO - Running setup.py (path:/tmp/pip-cYrsq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:33:38 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)) 15:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:33:38 INFO - Running setup.py (path:/tmp/pip-sfhBew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:33:38 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)) 15:33:38 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)) 15:33:38 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)) 15:33:38 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)) 15:33:38 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)) 15:33:38 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)) 15:33:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:33: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 15:33: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 15:33: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 15:33: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 15:33: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 15:33: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 15:33:40 INFO - Downloading blessings-1.6.tar.gz 15:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:33:40 INFO - Installing collected packages: blessings 15:33:40 INFO - Running setup.py install for blessings 15:33:40 INFO - Successfully installed blessings 15:33:40 INFO - Cleaning up... 15:33:40 INFO - Return code: 0 15:33:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:33:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:33:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:33:41 INFO - Reading from file tmpfile_stdout 15:33:41 INFO - Current package versions: 15:33:41 INFO - argparse == 1.2.1 15:33:41 INFO - blessings == 1.6 15:33:41 INFO - blobuploader == 1.2.4 15:33:41 INFO - docopt == 0.6.1 15:33:41 INFO - functools32 == 3.2.3-2 15:33:41 INFO - jsonschema == 2.5.1 15:33:41 INFO - manifestparser == 1.1 15:33:41 INFO - mozInstall == 1.12 15:33:41 INFO - mozcrash == 0.17 15:33:41 INFO - mozdebug == 0.1 15:33:41 INFO - mozdevice == 0.48 15:33:41 INFO - mozfile == 1.2 15:33:41 INFO - mozhttpd == 0.7 15:33:41 INFO - mozinfo == 0.9 15:33:41 INFO - mozleak == 0.1 15:33:41 INFO - mozlog == 3.4 15:33:41 INFO - moznetwork == 0.27 15:33:41 INFO - mozprocess == 0.23 15:33:41 INFO - mozprofile == 0.28 15:33:41 INFO - mozrunner == 6.12 15:33:41 INFO - mozscreenshot == 0.1 15:33:41 INFO - mozsystemmonitor == 0.3 15:33:41 INFO - moztest == 0.7 15:33:41 INFO - mozversion == 1.4 15:33:41 INFO - psutil == 3.1.1 15:33:41 INFO - requests == 1.2.3 15:33:41 INFO - wsgiref == 0.1.2 15:33:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:33:41 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')]} 15:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:41 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')]} 15:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:41 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 0x7f5436ac2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4bf60>, '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 0x2c4cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c4d1d0>, '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': '920470bf432669ad7e3a5387000001ca-1474151583.365078-923415544', '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 15:33:41 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 15:33:41 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 15:33:41 INFO - Using env: {'DISPLAY': ':0', 15:33:41 INFO - 'HOME': '/home/cltbld', 15:33:41 INFO - 'LANG': 'en_US.UTF-8', 15:33:41 INFO - 'LANGUAGE': 'en_US:en', 15:33:41 INFO - 'LOGNAME': 'cltbld', 15:33:41 INFO - 'MAIL': '/var/mail/cltbld', 15:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:41 INFO - 'MOZ_NO_REMOTE': '1', 15:33:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:41 INFO - 'NO_EM_RESTART': '1', 15:33:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:41 INFO - 'PWD': '/builds/slave/test', 15:33:41 INFO - 'SHELL': '/bin/bash', 15:33:41 INFO - 'SHLVL': '1', 15:33:41 INFO - 'TERM': 'linux', 15:33:41 INFO - 'TMOUT': '86400', 15:33:41 INFO - 'USER': 'cltbld', 15:33:41 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1474151583.365078-923415544', 15:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:41 INFO - '_': '/tools/buildbot/bin/python'} 15:33:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:41 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)) 15:33:41 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)) 15:33:41 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)) 15:33:41 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)) 15:33:41 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)) 15:33:41 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)) 15:33:41 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)) 15:33:41 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)) 15:33:41 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)) 15:33:41 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)) 15:33:41 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)) 15:33:41 INFO - Cleaning up... 15:33:41 INFO - Return code: 0 15:33:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:33:41 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')]} 15:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:41 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')]} 15:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:41 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 0x7f5436ac2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4bf60>, '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 0x2c4cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c4d1d0>, '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': '920470bf432669ad7e3a5387000001ca-1474151583.365078-923415544', '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 15:33:41 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 15:33:41 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 15:33:41 INFO - Using env: {'DISPLAY': ':0', 15:33:41 INFO - 'HOME': '/home/cltbld', 15:33:41 INFO - 'LANG': 'en_US.UTF-8', 15:33:41 INFO - 'LANGUAGE': 'en_US:en', 15:33:41 INFO - 'LOGNAME': 'cltbld', 15:33:41 INFO - 'MAIL': '/var/mail/cltbld', 15:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:41 INFO - 'MOZ_NO_REMOTE': '1', 15:33:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:41 INFO - 'NO_EM_RESTART': '1', 15:33:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:41 INFO - 'PWD': '/builds/slave/test', 15:33:41 INFO - 'SHELL': '/bin/bash', 15:33:41 INFO - 'SHLVL': '1', 15:33:41 INFO - 'TERM': 'linux', 15:33:41 INFO - 'TMOUT': '86400', 15:33:41 INFO - 'USER': 'cltbld', 15:33:41 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1474151583.365078-923415544', 15:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:41 INFO - '_': '/tools/buildbot/bin/python'} 15:33:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:33:41 INFO - Cleaning up... 15:33:41 INFO - Return code: 0 15:33:41 INFO - Running post-action listener: _resource_record_post_action 15:33:41 INFO - Running post-action listener: _start_resource_monitoring 15:33:41 INFO - Starting resource monitoring. 15:33:41 INFO - [mozharness: 2016-09-17 22:33:41.525783Z] Finished create-virtualenv step (success) 15:33:41 INFO - [mozharness: 2016-09-17 22:33:41.526230Z] Running install step. 15:33:41 INFO - Running pre-action listener: _resource_record_pre_action 15:33:41 INFO - Running main action method: install 15:33:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:33:41 INFO - Reading from file tmpfile_stdout 15:33:41 INFO - Detecting whether we're running mozinstall >=1.0... 15:33:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:33:41 INFO - Reading from file tmpfile_stdout 15:33:41 INFO - Output received: 15:33:41 INFO - Usage: mozinstall [options] installer 15:33:41 INFO - Options: 15:33:41 INFO - -h, --help show this help message and exit 15:33:41 INFO - -d DEST, --destination=DEST 15:33:41 INFO - Directory to install application into. [default: 15:33:41 INFO - "/builds/slave/test"] 15:33:41 INFO - --app=APP Application being installed. [default: firefox] 15:33:41 INFO - mkdir: /builds/slave/test/build/application 15:33:41 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'] 15:33:41 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 15:33:57 INFO - Reading from file tmpfile_stdout 15:33:57 INFO - Output received: 15:33:57 INFO - /builds/slave/test/build/application/firefox/firefox 15:33:57 INFO - Running post-action listener: _resource_record_post_action 15:33:57 INFO - [mozharness: 2016-09-17 22:33:57.885004Z] Finished install step (success) 15:33:57 INFO - [mozharness: 2016-09-17 22:33:57.885248Z] Running run-tests step. 15:33:57 INFO - Running pre-action listener: _resource_record_pre_action 15:33:57 INFO - Running main action method: run_tests 15:33:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:33:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:33:57 INFO - Python 2.7.3 15:33:57 INFO - Return code: 0 15:33:57 INFO - grabbing minidump binary from tooltool 15:33:57 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')]} 15:33:57 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 0x2c4bf60>, '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 0x2c4cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c4d1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:33:57 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 15:33:57 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 15:33:57 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 15:33:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:33:57 INFO - Return code: 0 15:33:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:33:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:33:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:33:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:33:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:33:57 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/AwgkQsfLSCe89EXhAwZE3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 15:33:57 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/AwgkQsfLSCe89EXhAwZE3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 15:33:57 INFO - Using env: {'DISPLAY': ':0', 15:33:57 INFO - 'HOME': '/home/cltbld', 15:33:57 INFO - 'LANG': 'en_US.UTF-8', 15:33:57 INFO - 'LANGUAGE': 'en_US:en', 15:33:57 INFO - 'LOGNAME': 'cltbld', 15:33:57 INFO - 'MAIL': '/var/mail/cltbld', 15:33:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:33:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:33:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:57 INFO - 'MOZ_NO_REMOTE': '1', 15:33:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:33:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:57 INFO - 'NO_EM_RESTART': '1', 15:33:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:57 INFO - 'PWD': '/builds/slave/test', 15:33:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:33:57 INFO - 'SHELL': '/bin/bash', 15:33:57 INFO - 'SHLVL': '1', 15:33:57 INFO - 'TERM': 'linux', 15:33:57 INFO - 'TMOUT': '86400', 15:33:57 INFO - 'USER': 'cltbld', 15:33:57 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1474151583.365078-923415544', 15:33:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:57 INFO - '_': '/tools/buildbot/bin/python'} 15:33:57 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/AwgkQsfLSCe89EXhAwZE3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 15:33:58 INFO - mozversion application_buildid: 20160917140433 15:33:58 INFO - mozversion application_changeset: eaf5eb6f8fa0d8e7a09f3774c0da53c0dd6dadd7 15:33:58 INFO - mozversion application_display_name: Nightly 15:33:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:33:58 INFO - mozversion application_name: Firefox 15:33:58 INFO - mozversion application_remotingname: firefox 15:33:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:33:58 INFO - mozversion application_vendor: Mozilla 15:33:58 INFO - mozversion application_version: 51.0a1 15:33:58 INFO - mozversion platform_buildid: 20160917140433 15:33:58 INFO - mozversion platform_changeset: eaf5eb6f8fa0d8e7a09f3774c0da53c0dd6dadd7 15:33:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:33:58 INFO - mozversion platform_version: 51.0a1 15:33:58 INFO - using testdate: 1474151638 15:33:58 INFO - actual date: 1474151638 15:33:58 INFO - starting webserver on 'localhost:37089' 15:33:58 INFO - SUITE-START | Running 2 tests 15:33:58 INFO - TEST-START | dromaeo_css 15:33:58 INFO - operating with platform_type : linux_ 15:33:58 INFO - Initialising browser for dromaeo_css test... 15:33:58 INFO - TEST-INFO | started process 28971 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7M9Fm2/profile http://localhost:37089/getInfo.html) 15:34:02 INFO - PROCESS | 28971 | __metrics Screen width/height:1600/1200 15:34:02 INFO - PROCESS | 28971 | colorDepth:24 15:34:02 INFO - PROCESS | 28971 | Browser inner width/height: 1024/697 15:34:02 INFO - PROCESS | 28971 | __metrics 15:34:03 INFO - PROCESS | 28971 | 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" 15:34:03 INFO - PROCESS | 28971 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:34:04 INFO - PROCESS | 28971 | console.error: PushService: 15:34:04 INFO - PROCESS | 28971 | stateChangeProcessEnqueue: Error transitioning state 15:34:04 INFO - PROCESS | 28971 | UnknownError 15:34:04 INFO - TEST-INFO | 28971: exit 0 15:34:04 INFO - Browser initialized. 15:34:04 INFO - Running cycle 1/1 for dromaeo_css test... 15:34:04 INFO - TEST-INFO | started process 29049 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7M9Fm2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:34:16 INFO - PROCESS | 29049 | RSS: Main: 175316992 15:34:16 INFO - PROCESS | 29049 | 15:34:20 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.15005 seconds. 15:34:39 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 15:34:54 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.03337 seconds. 15:34:56 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 15:35:01 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 15:35:08 INFO - PROCESS | 29049 | 1474151708490 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] 15:35:11 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 15:35:19 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.05004 seconds. 15:35:32 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 15:35:34 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01675 seconds. 15:35:50 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.16672 seconds. 15:35:57 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.03343 seconds. 15:36:00 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.03341 seconds. 15:36:03 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.20009 seconds. 15:36:05 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.05001 seconds. 15:36:07 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 15:36:11 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.16673 seconds. 15:36:27 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:36:28 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 2.00007 seconds. 15:36:29 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:36:31 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.16672 seconds. 15:36:37 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.05005 seconds. 15:36:45 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:36:53 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 15:37:19 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 15:37:21 INFO - PROCESS | 29049 | Cycle 1(1): loaded http://localhost:37089/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37089/tests/dromaeo/cssquery-ext.html) 15:37:22 INFO - PROCESS | 29049 | RSS: Main: 255741952 15:37:22 INFO - PROCESS | 29049 | 15:37:25 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01668 seconds. 15:37:26 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01667 seconds. 15:37:28 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 15:37:37 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 15:37:49 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:37:57 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:38:09 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01675 seconds. 15:38:15 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 15:38:21 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 15:38:23 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 15:38:27 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01658 seconds. 15:38:31 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00319 seconds. 15:38:47 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 15:39:01 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 15:39:21 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 15:39:23 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 15:39:30 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00009 seconds. 15:39:48 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:39:52 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 15:39:57 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 15:40:12 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:40:24 INFO - PROCESS | 29049 | Cycle 1(1): loaded http://localhost:37089/tests/dromaeo/cssquery-ext.html (next: http://localhost:37089/tests/dromaeo/cssquery-jquery.html) 15:40:25 INFO - PROCESS | 29049 | RSS: Main: 269897728 15:40:25 INFO - PROCESS | 29049 | 15:40:28 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.03339 seconds. 15:40:33 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:40:35 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 15:40:50 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 15:41:00 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 15:41:08 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:41:10 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:41:12 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:41:14 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 15:41:18 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:41:26 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 15:41:34 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 15:41:54 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:42:01 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 15:42:09 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01675 seconds. 15:42:11 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 15:42:15 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 15:42:17 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 15:42:19 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 15:42:21 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 15:42:29 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:42:31 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:42:33 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:42:37 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:42:41 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:42:45 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 15:42:49 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 15:42:51 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:42:57 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00011 seconds. 15:43:01 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 15:43:05 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:43:17 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 15:43:19 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 15:43:21 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:43:23 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1 seconds. 15:43:27 INFO - PROCESS | 29049 | Cycle 1(1): loaded http://localhost:37089/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37089/tests/dromaeo/cssquery-mootools.html) 15:43:28 INFO - PROCESS | 29049 | RSS: Main: 262361088 15:43:28 INFO - PROCESS | 29049 | 15:43:31 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.03342 seconds. 15:43:45 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:43:49 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:43:55 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:43:59 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 15:44:01 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:44:05 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:44:11 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 15:44:15 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00447 seconds. 15:44:17 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:44:19 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:44:23 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:44:27 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:44:37 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 15:44:45 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:45:27 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 15:45:28 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:45:30 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:45:32 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:45:40 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:45:44 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 15:45:46 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:45:48 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:45:58 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 15:46:22 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:46:26 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:46:30 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:46:30 INFO - PROCESS | 29049 | Cycle 1(1): loaded http://localhost:37089/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37089/tests/dromaeo/cssquery-prototype.html) 15:46:31 INFO - PROCESS | 29049 | RSS: Main: 218996736 15:46:31 INFO - PROCESS | 29049 | 15:46:38 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 15:46:47 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00234 seconds. 15:46:59 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 15:47:00 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:47:07 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:47:08 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 15:47:28 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 15:47:30 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:47:45 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 15:47:48 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:47:55 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 15:47:56 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:47:58 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:48:13 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.0037 seconds. 15:48:31 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:48:32 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 2.00006 seconds. 15:48:33 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 15:48:34 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 2.00007 seconds. 15:48:35 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 15:48:40 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:48:45 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:48:47 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:48:49 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:48:51 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:48:53 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:48:58 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:49:04 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 15:49:06 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 15:49:10 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 15:49:14 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 15:49:16 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 15:49:18 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:49:22 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:49:24 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01666 seconds. 15:49:26 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:49:28 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.03338 seconds. 15:49:33 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 15:49:34 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:49:34 INFO - PROCESS | 29049 | Cycle 1(1): loaded http://localhost:37089/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37089/tests/dromaeo/cssquery-yui.html) 15:49:34 INFO - PROCESS | 29049 | RSS: Main: 219529216 15:49:34 INFO - PROCESS | 29049 | 15:49:40 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.03338 seconds. 15:49:53 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 15:50:05 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:50:12 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 15:50:19 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:50:28 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:50:32 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 15:50:39 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.03337 seconds. 15:50:40 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:50:51 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 15:51:08 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01666 seconds. 15:51:09 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 2.0167 seconds. 15:51:38 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:51:41 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:51:43 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:51:45 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:51:47 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:51:49 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:51:53 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:51:58 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:51:59 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 15:52:00 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 2.00005 seconds. 15:52:01 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:52:03 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:52:13 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.01667 seconds. 15:52:23 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:52:31 INFO - PROCESS | 29049 | [GFX1-]: Refresh driver waiting for the compositor for 1.05004 seconds. 15:52:37 INFO - PROCESS | 29049 | Cycle 1(1): loaded http://localhost:37089/tests/dromaeo/cssquery-yui.html (next: http://localhost:37089/tests/dromaeo/cssquery-dojo.html) 15:52:38 INFO - PROCESS | 29049 | RSS: Main: 293908480 15:52:38 INFO - PROCESS | 29049 | 15:52:38 INFO - PROCESS | 29049 | __start_tp_report 15:52:38 INFO - PROCESS | 29049 | _x_x_mozilla_page_load 15:52:38 INFO - PROCESS | 29049 | _x_x_mozilla_page_load_details 15:52:38 INFO - PROCESS | 29049 | |i|pagename|runs| 15:52:38 INFO - PROCESS | 29049 | |0;dojo.html;2528.1657053172453;2557.8721063946796;2584.05681926097;2589.520938626354;2598.896044158234;4527.932081018787;4604.907901841962;4634.258518637014;4646.860594182176;4652.348671186037;4609.792559334838;4629.421322334708;4633.698809577383;4666.626669866411;4687.20317546018;4243.257429949762;4263.8081286342185;4289.871303860889;4291.0988692374485;4363.454568178978;4306.892327691817;4362.0621566363225;4383.189110014641;4399.296112621981;4417.293233082707;4191.601797829201;4253.829846806124;4344.587264209895;4349.043210493686;4354.477462704464;4275;4294.355846623001;4294.935575966332;4295.656347492193;4297.183535128315;4262.7655478948645;4267.850625228133;4268.295731204347;4268.765217913014;4277.593628605277;4527.388802511652;4574.61115805157;4597.37935378723;4628.236341003731;4634.073185362941;4889.095517329305;4891;4896.779644915988;4938.086454005985;4948.282499037619;4892.437369702494;4897.179046609857;4904.239842824368;4928.531789479994;4964.05682920244;4502.144592527409;4508.143452744033;4552.271636538138;4603.723776573383;4647.302904564309;4977.875553111129;4990.525900039491;4992.600591952635;4993.325901003391;4997.200447928314;4778.713277203379;4809.95190048102;4814.253790662453;4819.855404337875;4823.807047718122;4882.292067650171;4937.703737775745;4998.700077995332;5005.224190250517;5059.241113832954;4966.950330496648;4967.031428871335;4971.825986090469;4975.303457515951;5022.84931452057;4933.703977761345;4952.207646776498;4955.157623204064;4961.578265847371;5006.799728010911;4057.229126465962;4115.259253334369;4119.526254480713;4132.648724858421;4155.1897380010605;3635.2547727715755;3645.398509245998;3680.0431887709387;3690.206605579813;3701.8149092545264;4154.771487568152;4194.224068547329;4194.706370554032;4241.130568233505;4242.957570424318;4825.203841366206;4980.203167493184;4981.9252711209365;4983.800647974041;5033.6224783141415;4079.8164082616354;4183.728057676241;4233.682473814476;4237.87286381409;4279.122779830127;4495.595396414338;4496.797644106023;4542.500324964251;4550.385697930737;4555.931661025087;4717.599004084691;4718.787654555554;4722.52774722525;4723.858284251478;4778.880527986828;4857.0528746894015;4920.114379411741;4957.801687932442;5015.724135172601;5019.0463811875625;4674;4674.135284972291;4677.976610116928;4734.455537613218;4739.265413860857;4886.92669609949;4887.462379138363;4891.584215341736;4894.437139728977;4954.5788607968725;4807.062622788522;4878.926816097691;4905.583025442877;4948.1835497142565;5022.045811295842;4774.30772537987;4843.1524483216;4860.635452341018;4864.781084851119;4920.40955085392;4859.975700121477;4863.10032643962;4874.390701162355;4875.512448755097;4929.531694489017;4631.444226692818;4794.856154315376;4799.352087468287;4809.879753006203;4872.585830204473;4760.666753327372;4810.6632535722165;4813.03739252158;4861.052094841472;4862.95137048625;4746.78639461232;4754.809807607657;4783.425988881357;4785.3779008730035;4815.446223684321 15:52:38 INFO - PROCESS | 29049 | |1;ext.html;548.4707257496516;550.5182964905707;562.6511562831045;563.8703098287393;564.3848205456052;28549;31469.527957080605;31537.68462315379;31550.684493155062;31559.684403155963;31983.840080799622;32714.182145446317;44459.77770111153;45880.31179532301;45962.31056534155;7567.962160189205;7679.385649148055;7695.538267703956;7697.769066927973;7701.845963080735;7623.733169339074;7716.189800070968;7723.343515801135;7724.382049436032;7727.343175830061;7762.883556746625;7799.181085985975;7802.024746906637;7803.687852485894;7804.336631386339;7691.153973062958;7739.61301934901;7750.379969602418;7750.961245193795;7751.689932402697;7450.441216908754;7497.625118744041;7515.323620874093;7516.962415187943;7517.849643007109;39223.8038809807;39478.40782388266;39772.403413948814;39805.402918956235;40072.198556028714;2927.077970439305;2988.417258634567;3036.149878034154;3125.890593829205;3196.2329041029984;29260.70739292601;29533.261668458246;29562.556561651592;29987.400251995055;31016;3369.932601347984;3463.9134021649406;3498.405271103893;3520.77114987525;3571.94642080369;260891;260902;261401;261935;262172.689136555;31759.52360714591;32865.178370540925;32907.17732056718;55880.6029849257;56372.71813640906;34236;34320.82839585786;34418.82790586081;34466.82766586151;34474.482882756776;13553.728925421436;13705.520306789414;13719;13720.519781807589;13742.244176570384;11129.777404451866;11191.2725672831;11194.160437967184;11220.046296064762;11307.717307067389;7668.348190403878;7798.649060792278;7854.646540905673;7890.566018869017;7922.247386498273;3091.536269559584;3097.396007778507;3097.9535306970415;3111.968880311213;3149.9212519686735;836.1554829622125;848.6138806842995;895.9910400895908;928.4475736936512;970.8058388322364;26314.473710525683;26422.6036609451;27081.32296692559;27141.86429067842;27394.315142121206;794.3168874767695;965.5510187762724;992.2062350119875;994.0159242350165;1004.1314263162312;13589.320533973261;14668.119912805267;14759.77860332096;14870.107793532423;14936.32786524609;385434;390502;390864;392384;392386;49003.509964899895;49637.75181124071;49686.50313496891;49774;49781;1077.1167642533048;1117.8714447838602;1161.4947497838468;1182.810750279951;1226.8957138643316;27129.321766955985;28852;29176.562351565168;29427.871594710643;29667.55498667565;42679.78660106679;42877;43010.35484467673;43118.35322470103;43151;236425;236592;236838;237252;237859;24801.25596232116;25438.109666162334;25485.872570637028;25576.74423255818;26739.732602673725;40986.59013409947;41236.58763412447;41257.96855078647;41319.58680413158;42053;35238.647613523535;35409.783624649455;35518.64481355153;35615;35767.46348804718;34874.30251395009;35679;35765.28469430649;35796.284074318886;36053;34476.482852757734;34836.82581587177;35018.29963400667;35163.82418087996;35171.47242791309;30185;32045.67954320427;32461.67538324681;32461.837690811393;32503.837480812446;24383.878080609484;24502.754972450046;24576.084783043105;25229.495410092062;25272.62091068672 15:52:38 INFO - PROCESS | 29049 | |2;jquery.html;341.1233130853707;361.1765175400087;366.78543052314393;373.24976796638765;391.843262694922;12345.876541234586;15610;15802.604934876634;16908.323667053304;17028.659426811486;16509.752353714674;16762.161891905416;17099.572510687238;17215.139243037862;17242.913785431087;4820.445648750386;4884.169691152495;4915.115279249733;5068.974655126728;5140.151949755811;3689.1883785567265;3881.3789793633023;4938.580220681229;5020;5023.623228257877;5734.254546908896;5999.280086389639;6024.427679370475;6112.602680825732;6130.816075517741;5178.741062946875;5427.592930530226;5463.153211252262;6108.511319094462;6116.266048074215;5343.171808369709;5353.9196912046355;5359.758810853521;5364.785408583652;5365.490278423544;12477.688057798538;12598.433070511848;12896.613101606967;12938.935305323508;12995.870041299655;1802.7295905614133;2108.2726459371493;2133.4133113393787;2314.132200424841;2342.5314937012495;8850.424722393089;9101.681441149594;9700.563474643657;9984.850227246598;13669.453221871114;1708.8376604222578;1745.9912700436544;1751.5445984044113;1765.3027054313602;1802.1349752119056;67329.3267067328;70923.64538177276;72362.78376851596;72904;74763.62618186929;8459.788505287293;9080.8637870432;9080.8637870432;9085.68200113006;10080.647177348905;12082.637520874388;12163.331016793984;12183.512659493521;12186.695332616755;12191.268523888595;6980.895286570705;7084.681189346492;7175.390091842148;7363.226861179606;7367.447441441914;7084.43324534036;7139.750108746169;7197.1363436387965;7361.227071157558;7396.963015184997;3573.160307327776;3618.9819050905103;3818.770873747584;3872.186840763471;3890.8054597270025;1772.831580999803;1796.8472679822362;1850.80566540514;1855.879367841086;1863.7419741674316;798.9480683755653;813.9145389733993;842.8735689646479;862.9697960571475;906.7506435730227;16190.271437785328;16406.507804765875;16925.830741692673;17527.561810954827;17633.647327053386;846.9280111190494;861.5476874640864;880.7798050487378;885.3138817416425;899.2266650680409;9153.267738580898;9513.904860951441;9722.659706910224;9788.363756355815;9969.35199212049;375662;375976;384897.8122625247;386001;386681;79183;80414.59792700999;82132.58933705294;83748;84423.15576844275;901.2069378946354;920.0431551186824;943.9244860411151;945.0313428735464;945.9668911588061;14584.489542866373;14715.92642036783;15078.396864125312;15152.848471515144;15414.075155490706;25558;25846.22461326163;35790.28419431545;37640.62359376481;37650.246995060494;46556.7672161637;47324.2901356473;47918.52081479141;55087;56115.71942140263;7287.307705767944;7637.465377423527;7660.3488703460835;7819.609019549113;7948.330850521455;9008;11799.646010619696;11981.400929953641;12181.939090304491;12283.447244874182;10199.490025498548;10290.279680422298;10352.792944141225;10763.192760543147;10893.400862952614;10328.380297182193;10655.094316983143;10719.732006699584;10756;11000.834987475355;10074.798504029732;10512.78974420492;10537.15702743794;10736.463176841284;10753.58044440026;7395.630218489162;7526.661300241392;7602.657880395285;7858.44990850635;7887.64505597238;10160.441175735405;10212.234082443698;10347.172226222036;10433.634822781167;10972.506237219184 15:52:38 INFO - PROCESS | 29049 | |3;mootools.html;1222.1750318534998;1364.8362196536411;1385.0097180515932;1477.5271912987848;1706.0616660836538;6808.727650893965;7568.62156892156;7808.492447990877;7885.1326354101;8147.837043259146;7936.563489008102;8010.719624813133;8016.478928869619;8026.8394632107465;8029.5182289062695;2182.476205710626;2222.7777222277805;2223.444138965259;2223.455253462904;2224.421650370899;2169.457635591102;2195.418214173237;2228.3983324502456;2233.687283780272;2233.8771367574777;2171.207509259117;2177.967330490044;2202.90086946087;2204.481946742514;2216.4569680428317;2151.268568686646;2158.4064382294996;2160.4058883807;2161.556880839424;2161.6217161996747;2158.3740715192575;2203.4711669199437;2204.4599073227;2215.1471683401846;2218.889055547232;7959.164287749819;7975.760727178136;8019.839603207904;8024.839503209962;8027.317677997377;4348.869533913988;4514.300283456069;4535.206338890681;4574.382458368144;4577.169132347054;2757.352022274764;2817.1266907258814;2866.5270230411957;2880.510313246753;2890.913272601825;956.7608097975506;961.1637875048682;970.9804705059659;978.7406337320616;978.8091322192175;10891.237613367068;10936.12510999126;10982.560697572168;11036.944815275952;11083.833742493869;4040.5151381834366;4091.672666186698;4186.958130418718;4198.958010419857;4212.957870421318;8651.351148663749;8658.051938313829;8661.263792577702;8661.870071948926;8662.177093176138;4516.07420478801;4534.6372290216705;4544.886377840514;4545.022820093695;4545.522720114406;3578.3916734154736;3650.9634903651154;3793.7723736575895;4156.106437115974;4157.958420415817;3168.730657894059;3493.318802833474;3523.5419395478425;3541.9291614167573;3550.5916819565564;1039.1738567838586;1063.6064656077301;1068.957241710323;1080.5785743560018;1089.0688461365576;657.3360905485495;768.047620950018;781.2929298984428;786.4573444323398;797.4417907464798;4879.072976134523;4994.051130285234;4999.825076091912;5000.524950129732;5092.490750924952;408.60977766233174;408.9100397912454;410.2512913932086;412.65955586641144;419.5804195804196;3305.1571849178304;3423.7945723256685;3462.567179102612;3472.340255351475;3492.877749278763;9237.261019118589;9449;9527.475988820543;9541.141297283139;9619.134277915022;9415.670451534163;9427.292953028551;9447.858282125773;9474.763130921781;9498.430094194371;7074.151101867706;7119.964400177966;7136;7142.250063743232;7149.642517874189;4797.928031079607;4819.349387832598;4946.579540739078;4951.944942848678;5001.64988450805;8571.314294856273;8618.05201427855;8746.125387461458;8758.255548278214;8768.561571921506;8780.824383512167;8867.91132088671;8887.422317549339;8979.955100224457;8996.460212387277;6214.8135555933395;6256.311805701278;6256.718447669775;6265.4361107500545;6270.592411493239;7000.299970003162;7224.2414546473965;7278.927210728037;7280.490365674564;7423.406127509894;6481.902771458526;6520.869582608227;6547.312532184243;6602;6879.415249703631;6518.282988871315;6647.534672572873;6676.0987266718375;6761.357671021246;6894.724211031503;6130.540209484396;6208.627482351073;6244.063390491463;6281.685915704288;6283.96858015707;4414.9558504414545;4450.354698568754;4536.56902594253;4573.222552166207;4628.421447319085;4368.934465982949;4571.908561828678;4587.885302867455;4610.492845787028;4664.533546645308 15:52:38 INFO - PROCESS | 29049 | |4;prototype.html;299.32054236882277;305.7721997112152;309.25161110113515;311.72256691544527;314.0938392736953;4780.8565743027675;4820.132376172288;4823.5417635324675;4827.44484384295;4850.223964165734;4706.788194531246;4770.236762118062;4773;4776.68951518152;4789.209780386241;3607.621199774025;3728.7203459740495;3737.588865224837;3740.9625903740884;3759.248150369923;3652.8904132875923;3749.2501499700033;3782.73520853539;3791.5450145982522;3828.157805282833;3734.916874106506;3736.1967177056927;3738.7943663098517;3748.269087527933;3750.1749615084636;3528.188516641161;3701.8519259229597;3742.6631603155847;3749.2501499700033;3762.5673047599466;3262.559554460165;3266.836658167082;3268;3269.7874638148683;3271.4765637497885;4619.16854966106;4619.260918253063;4623.514530974267;4629.884252893705;4640.76796160194;4207.389928460356;4228.577142285778;4252.425922500453;4254;4254.255505286563;4717.292406139072;4928.137575924199;4937.851864444036;4968.056069346849;5006;3568.3398571264397;3575.6960658344074;3576.8211589420685;3577.3560759063357;3579.818659842246;5141.742912854343;5168.5606723428555;5179.430262671103;5228.660137091077;5251.422343542207;3538.7522873398616;3593.82030898454;3623.329684008414;3676.411774116182;3685.2076803486843;3671.30245253401;3674.65090816372;3676.5036720042986;3690.4648825920626;3698.6486283802997;4169.708120431601;4170.124273902454;4183.644390226804;4195.706300558993;4203.726757760797;4890.364252647133;4891.853244402673;4927.60579153674;4931.605471562267;4934.358533390708;1227.864934857165;1273.81529678198;1278.3672082319126;1285.1774864086992;1285.8456985161654;802.3821657323945;816.5141740664295;819.9344052475788;831.4595512916652;839.7942504086416;4123.402106694512;4145.461090058273;4233.5131459881895;4295.591918767712;4306.569343065668;5102.872428189325;5117.283580298761;5122.692638441706;5130.4356520782685;5134.87162820925;4320.632746216544;4324.84286470878;4325.891852703708;4327.221100201994;4334.306510958231;2614.764671179565;2663.3741070848337;2688.2338533518246;2697.2717366311376;2708.7968402369506;4793.18515852306;4798.520147985174;4808.975955120202;4811.230203167476;4813.422389313305;5196.220566914993;5200.271961925334;5227.869303267373;5229.843104706865;5230.293910322134;4583.702059366131;4837.201861692782;4867.221244600847;4870.853874383774;4871.8294859679745;5128.615353848401;5132.5628823929355;5135.226977432145;5147.974260128675;5169.172932330809;4867.659263851638;5048.813528820798;5059.392872855134;5074.441811400817;5097.93533618885;4834;4846;4853.927191092066;4870.586000190024;4875.585575226004;3634.909127271839;3665.1020499977676;3668.4313931340685;3681.337359275249;3704.8332825023476;5119.692818430906;5150.356205474316;5151.304573882478;5166.509181627739;5186.4035635902355;4731.526847315241;4940.308356830118;4945.381827271591;4947.1448206922405;4977.477364876636;4943.541655211793;4950.727709975986;4960.23116416956;4960.900781984412;5000.549730632037;4860.222364421676;4882.438519570295;4886.218205087169;4891.828785992473;4901.3383193268455;4726.881827954328;4737.763111844325;4871.683340582851;4944.653874228769;4989.351384320015;4793.520647935178;4901.50984901507;4920.901581968412;4925.408950925768;4935.481774413634 15:52:38 INFO - PROCESS | 29049 | |5;yui.html;545.7898708997035;572.8338781753289;626.3454689849107;680.8706345794299;716.0548076538969;12437;13058.673533161676;13149.079564430494;13154.671133221675;13159.473621055145;12911.418986145622;12993;13029.153105048164;13030.15304005239;13031.348432578381;615.3815415507408;630.9558330916838;745.7650839985414;759.6163937211701;776.1501156233915;746.9141048779405;768.3238749900108;769.5421224371518;773.8374941262342;775.5346791924857;805.6213579617599;809.6437567470294;811.1766556944676;811.6591031766643;812.3744716568239;638.773235501395;655.3315618069543;780.3484090784202;807.7778610881995;808.0505406147753;589.9380565040652;591.0189086117068;591.9230500035011;592.170960655082;592.8458600763789;12224.572139975147;12240.081993850497;12266.8959793619;12278.570250041295;12294.385280735927;11234.382108984002;11478;11538.884611153864;11567.53729850805;12218.389080545938;10459.947700261526;10600.946995264974;10787.244892857503;10848.349099054081;10897.782044359148;3926.980365098185;3943.2507823513442;3945.842166313344;3981.7411868228473;4026.375911733686;52951.735241323935;54340.18489722657;54653.726731366485;60444;64468.3553164467;10003.099721025143;10379.532921018572;10419.583216671248;10423.218258630633;10592.682219533272;18139.54651133732;18433.72349414733;18761.624767504847;18777.15502802377;18789.90605046966;6902.861942761117;6979.720811167598;7030.050943122716;7114.71541138359;7212.567245965154;3541.5395998520025;3648.872289469856;3705.8517659293866;3716.535433070866;3764.8494060237285;2919.6350456192977;3055.984720076385;3058.2507285714696;3068.3403068340413;3075.538669199593;511.27654369068097;520.7084032941489;529.4811085136588;531.0971348707136;534.4762133109574;446.63822303933915;450.94363204599426;465.14181335436064;466.55677106748726;474.3513567042965;7595.810104747426;7833.843323133619;7923.881141782877;7924.920750792534;7975.082865470429;441.8342575446951;468.32093464476645;508.6083715539088;517.6505858545466;519.3508114856429;3548.8048157351077;3575.5530558680166;3579.3736096183065;3605.963940360615;3650.251698401821;103980;104463;105195;107040;107931;52066.21900671493;53726.46273537293;56775.71612141913;88910;92124;77453.61273193598;81403;81547.18452815515;82316.17683823204;82430;7038.718451261892;7279.781606551812;7390.5196162249285;7651.234876512304;7753.263439973193;43367.78316108399;44693.77653111714;45156.32265516085;45324.77337613291;47481.28778068263;56591.151132732215;60342.69828651004;64019.359806403205;64465;66399;9543.570539325608;9745.951270243604;9790.608375665179;9887.357321774061;10131.341462804894;10530.262881598215;10698.786024279627;10825.13398928068;10942.890571094187;10992.17558683118;10269.075783179549;10270.845937311096;10560.102391296827;10569.048785609331;10670.786584268117;9876.111149996535;10292.485375731034;10433.348328085109;10536.57853685844;10718.946405268236;9508.524573771421;9615.759606009906;9818.312718109664;10007.149392301735;10143.188544916537;8206.671733130608;8314.584270786558;8444.535550544779;8751.737447876574;8777.780555486164;8881.911180888108;9006.774830629287;9096.27229821626;9233.302582110757;9428.764280893032 15:52:38 INFO - PROCESS | 29049 | __end_tp_report 15:52:38 INFO - PROCESS | 29049 | __start_cc_report 15:52:38 INFO - PROCESS | 29049 | _x_x_mozilla_cycle_collect,1057 15:52:38 INFO - PROCESS | 29049 | __end_cc_report 15:52:38 INFO - PROCESS | 29049 | __startTimestamp1474152758100__endTimestamp 15:52:38 INFO - PROCESS | 29049 | 15:52:38 INFO - PROCESS | 29049 | ------- Summary: start ------- 15:52:38 INFO - PROCESS | 29049 | Number of tests: 6 15:52:38 INFO - PROCESS | 29049 | 15:52:38 INFO - PROCESS | 29049 | [#0] dojo.html Cycles:165 Average:4577.48 Median:4723.86 stddev:480.05 (10.2%) stddev-sans-first:453.80 15:52:38 INFO - PROCESS | 29049 | Values: 2528.2 2557.9 2584.1 2589.5 2598.9 4527.9 4604.9 4634.3 4646.9 4652.3 4609.8 4629.4 4633.7 4666.6 4687.2 4243.3 4263.8 4289.9 4291.1 4363.5 4306.9 4362.1 4383.2 4399.3 4417.3 4191.6 4253.8 4344.6 4349.0 4354.5 4275.0 4294.4 4294.9 4295.7 4297.2 4262.8 4267.9 4268.3 4268.8 4277.6 4527.4 4574.6 4597.4 4628.2 4634.1 4889.1 4891.0 4896.8 4938.1 4948.3 4892.4 4897.2 4904.2 4928.5 4964.1 4502.1 4508.1 4552.3 4603.7 4647.3 4977.9 4990.5 4992.6 4993.3 4997.2 4778.7 4810.0 4814.3 4819.9 4823.8 4882.3 4937.7 4998.7 5005.2 5059.2 4967.0 4967.0 4971.8 4975.3 5022.8 4933.7 4952.2 4955.2 4961.6 5006.8 4057.2 4115.3 4119.5 4132.6 4155.2 3635.3 3645.4 3680.0 3690.2 3701.8 4154.8 4194.2 4194.7 4241.1 4243.0 4825.2 4980.2 4981.9 4983.8 5033.6 4079.8 4183.7 4233.7 4237.9 4279.1 4495.6 4496.8 4542.5 4550.4 4555.9 4717.6 4718.8 4722.5 4723.9 4778.9 4857.1 4920.1 4957.8 5015.7 5019.0 4674.0 4674.1 4678.0 4734.5 4739.3 4886.9 4887.5 4891.6 4894.4 4954.6 4807.1 4878.9 4905.6 4948.2 5022.0 4774.3 4843.2 4860.6 4864.8 4920.4 4860.0 4863.1 4874.4 4875.5 4929.5 4631.4 4794.9 4799.4 4809.9 4872.6 4760.7 4810.7 4813.0 4861.1 4863.0 4746.8 4754.8 4783.4 4785.4 4815.4 15:52:38 INFO - PROCESS | 29049 | 15:52:38 INFO - PROCESS | 29049 | [#1] ext.html Cycles:180 Average:43964.65 Median:19186.35 stddev:80150.77 (417.7%) stddev-sans-first:80309.33 15:52:38 INFO - PROCESS | 29049 | Values: 548.5 550.5 562.7 563.9 564.4 28549.0 31469.5 31537.7 31550.7 31559.7 31983.8 32714.2 44459.8 45880.3 45962.3 7568.0 7679.4 7695.5 7697.8 7701.8 7623.7 7716.2 7723.3 7724.4 7727.3 7762.9 7799.2 7802.0 7803.7 7804.3 7691.2 7739.6 7750.4 7751.0 7751.7 7450.4 7497.6 7515.3 7517.0 7517.8 39223.8 39478.4 39772.4 39805.4 40072.2 2927.1 2988.4 3036.1 3125.9 3196.2 29260.7 29533.3 29562.6 29987.4 31016.0 3369.9 3463.9 3498.4 3520.8 3571.9 260891.0 260902.0 261401.0 261935.0 262172.7 31759.5 32865.2 32907.2 55880.6 56372.7 34236.0 34320.8 34418.8 34466.8 34474.5 13553.7 13705.5 13719.0 13720.5 13742.2 11129.8 11191.3 11194.2 11220.0 11307.7 7668.3 7798.6 7854.6 7890.6 7922.2 3091.5 3097.4 3098.0 3112.0 3149.9 836.2 848.6 896.0 928.4 970.8 26314.5 26422.6 27081.3 27141.9 27394.3 794.3 965.6 992.2 994.0 1004.1 13589.3 14668.1 14759.8 14870.1 14936.3 385434.0 390502.0 390864.0 392384.0 392386.0 49003.5 49637.8 49686.5 49774.0 49781.0 1077.1 1117.9 1161.5 1182.8 1226.9 27129.3 28852.0 29176.6 29427.9 29667.6 42679.8 42877.0 43010.4 43118.4 43151.0 236425.0 236592.0 236838.0 237252.0 237859.0 24801.3 25438.1 25485.9 25576.7 26739.7 40986.6 41236.6 41258.0 41319.6 42053.0 35238.6 35409.8 35518.6 35615.0 35767.5 34874.3 35679.0 35765.3 35796.3 36053.0 34476.5 34836.8 35018.3 35163.8 35171.5 30185.0 32045.7 32461.7 32461.8 32503.8 24383.9 24502.8 24576.1 25229.5 25272.6 15:52:38 INFO - PROCESS | 29049 | 15:52:38 INFO - PROCESS | 29049 | [#2] jquery.html Cycles:180 Average:23870.41 Median:3886.09 stddev:63302.03 (1628.9%) stddev-sans-first:63454.95 15:52:38 INFO - PROCESS | 29049 | Values: 341.1 361.2 366.8 373.2 391.8 12345.9 15610.0 15802.6 16908.3 17028.7 16509.8 16762.2 17099.6 17215.1 17242.9 4820.4 4884.2 4915.1 5069.0 5140.2 3689.2 3881.4 4938.6 5020.0 5023.6 5734.3 5999.3 6024.4 6112.6 6130.8 5178.7 5427.6 5463.2 6108.5 6116.3 5343.2 5353.9 5359.8 5364.8 5365.5 12477.7 12598.4 12896.6 12938.9 12995.9 1802.7 2108.3 2133.4 2314.1 2342.5 8850.4 9101.7 9700.6 9984.9 13669.5 1708.8 1746.0 1751.5 1765.3 1802.1 67329.3 70923.6 72362.8 72904.0 74763.6 8459.8 9080.9 9080.9 9085.7 10080.6 12082.6 12163.3 12183.5 12186.7 12191.3 6980.9 7084.7 7175.4 7363.2 7367.4 7084.4 7139.8 7197.1 7361.2 7397.0 3573.2 3619.0 3818.8 3872.2 3890.8 1772.8 1796.8 1850.8 1855.9 1863.7 798.9 813.9 842.9 863.0 906.8 16190.3 16406.5 16925.8 17527.6 17633.6 846.9 861.5 880.8 885.3 899.2 9153.3 9513.9 9722.7 9788.4 9969.4 375662.0 375976.0 384897.8 386001.0 386681.0 79183.0 80414.6 82132.6 83748.0 84423.2 901.2 920.0 943.9 945.0 946.0 14584.5 14715.9 15078.4 15152.8 15414.1 25558.0 25846.2 35790.3 37640.6 37650.2 46556.8 47324.3 47918.5 55087.0 56115.7 7287.3 7637.5 7660.3 7819.6 7948.3 9008.0 11799.6 11981.4 12181.9 12283.4 10199.5 10290.3 10352.8 10763.2 10893.4 10328.4 10655.1 10719.7 10756.0 11000.8 10074.8 10512.8 10537.2 10736.5 10753.6 7395.6 7526.7 7602.7 7858.4 7887.6 10160.4 10212.2 10347.2 10433.6 10972.5 15:52:38 INFO - PROCESS | 29049 | 15:52:38 INFO - PROCESS | 29049 | [#3] mootools.html Cycles:180 Average:5037.76 Median:4808.64 stddev:2878.61 (59.9%) stddev-sans-first:2872.40 15:52:38 INFO - PROCESS | 29049 | Values: 1222.2 1364.8 1385.0 1477.5 1706.1 6808.7 7568.6 7808.5 7885.1 8147.8 7936.6 8010.7 8016.5 8026.8 8029.5 2182.5 2222.8 2223.4 2223.5 2224.4 2169.5 2195.4 2228.4 2233.7 2233.9 2171.2 2178.0 2202.9 2204.5 2216.5 2151.3 2158.4 2160.4 2161.6 2161.6 2158.4 2203.5 2204.5 2215.1 2218.9 7959.2 7975.8 8019.8 8024.8 8027.3 4348.9 4514.3 4535.2 4574.4 4577.2 2757.4 2817.1 2866.5 2880.5 2890.9 956.8 961.2 971.0 978.7 978.8 10891.2 10936.1 10982.6 11036.9 11083.8 4040.5 4091.7 4187.0 4199.0 4213.0 8651.4 8658.1 8661.3 8661.9 8662.2 4516.1 4534.6 4544.9 4545.0 4545.5 3578.4 3651.0 3793.8 4156.1 4158.0 3168.7 3493.3 3523.5 3541.9 3550.6 1039.2 1063.6 1069.0 1080.6 1089.1 657.3 768.0 781.3 786.5 797.4 4879.1 4994.1 4999.8 5000.5 5092.5 408.6 408.9 410.3 412.7 419.6 3305.2 3423.8 3462.6 3472.3 3492.9 9237.3 9449.0 9527.5 9541.1 9619.1 9415.7 9427.3 9447.9 9474.8 9498.4 7074.2 7120.0 7136.0 7142.3 7149.6 4797.9 4819.3 4946.6 4951.9 5001.6 8571.3 8618.1 8746.1 8758.3 8768.6 8780.8 8867.9 8887.4 8980.0 8996.5 6214.8 6256.3 6256.7 6265.4 6270.6 7000.3 7224.2 7278.9 7280.5 7423.4 6481.9 6520.9 6547.3 6602.0 6879.4 6518.3 6647.5 6676.1 6761.4 6894.7 6130.5 6208.6 6244.1 6281.7 6284.0 4415.0 4450.4 4536.6 4573.2 4628.4 4368.9 4571.9 4587.9 4610.5 4664.5 15:52:38 INFO - PROCESS | 29049 | 15:52:38 INFO - PROCESS | 29049 | [#4] prototype.html Cycles:180 Average:4129.16 Median:4754.00 stddev:1197.17 (25.2%) stddev-sans-first:1165.51 15:52:38 INFO - PROCESS | 29049 | Values: 299.3 305.8 309.3 311.7 314.1 4780.9 4820.1 4823.5 4827.4 4850.2 4706.8 4770.2 4773.0 4776.7 4789.2 3607.6 3728.7 3737.6 3741.0 3759.2 3652.9 3749.3 3782.7 3791.5 3828.2 3734.9 3736.2 3738.8 3748.3 3750.2 3528.2 3701.9 3742.7 3749.3 3762.6 3262.6 3266.8 3268.0 3269.8 3271.5 4619.2 4619.3 4623.5 4629.9 4640.8 4207.4 4228.6 4252.4 4254.0 4254.3 4717.3 4928.1 4937.9 4968.1 5006.0 3568.3 3575.7 3576.8 3577.4 3579.8 5141.7 5168.6 5179.4 5228.7 5251.4 3538.8 3593.8 3623.3 3676.4 3685.2 3671.3 3674.7 3676.5 3690.5 3698.6 4169.7 4170.1 4183.6 4195.7 4203.7 4890.4 4891.9 4927.6 4931.6 4934.4 1227.9 1273.8 1278.4 1285.2 1285.8 802.4 816.5 819.9 831.5 839.8 4123.4 4145.5 4233.5 4295.6 4306.6 5102.9 5117.3 5122.7 5130.4 5134.9 4320.6 4324.8 4325.9 4327.2 4334.3 2614.8 2663.4 2688.2 2697.3 2708.8 4793.2 4798.5 4809.0 4811.2 4813.4 5196.2 5200.3 5227.9 5229.8 5230.3 4583.7 4837.2 4867.2 4870.9 4871.8 5128.6 5132.6 5135.2 5148.0 5169.2 4867.7 5048.8 5059.4 5074.4 5097.9 4834.0 4846.0 4853.9 4870.6 4875.6 3634.9 3665.1 3668.4 3681.3 3704.8 5119.7 5150.4 5151.3 5166.5 5186.4 4731.5 4940.3 4945.4 4947.1 4977.5 4943.5 4950.7 4960.2 4960.9 5000.5 4860.2 4882.4 4886.2 4891.8 4901.3 4726.9 4737.8 4871.7 4944.7 4989.4 4793.5 4901.5 4920.9 4925.4 4935.5 15:52:38 INFO - PROCESS | 29049 | 15:52:38 INFO - PROCESS | 29049 | [#5] yui.html Cycles:180 Average:17254.04 Median:514.46 stddev:25580.40 (4972.2%) stddev-sans-first:25621.39 15:52:38 INFO - PROCESS | 29049 | Values: 545.8 572.8 626.3 680.9 716.1 12437.0 13058.7 13149.1 13154.7 13159.5 12911.4 12993.0 13029.2 13030.2 13031.3 615.4 631.0 745.8 759.6 776.2 746.9 768.3 769.5 773.8 775.5 805.6 809.6 811.2 811.7 812.4 638.8 655.3 780.3 807.8 808.1 589.9 591.0 591.9 592.2 592.8 12224.6 12240.1 12266.9 12278.6 12294.4 11234.4 11478.0 11538.9 11567.5 12218.4 10459.9 10600.9 10787.2 10848.3 10897.8 3927.0 3943.3 3945.8 3981.7 4026.4 52951.7 54340.2 54653.7 60444.0 64468.4 10003.1 10379.5 10419.6 10423.2 10592.7 18139.5 18433.7 18761.6 18777.2 18789.9 6902.9 6979.7 7030.1 7114.7 7212.6 3541.5 3648.9 3705.9 3716.5 3764.8 2919.6 3056.0 3058.3 3068.3 3075.5 511.3 520.7 529.5 531.1 534.5 446.6 450.9 465.1 466.6 474.4 7595.8 7833.8 7923.9 7924.9 7975.1 441.8 468.3 508.6 517.7 519.4 3548.8 3575.6 3579.4 3606.0 3650.3 103980.0 104463.0 105195.0 107040.0 107931.0 52066.2 53726.5 56775.7 88910.0 92124.0 77453.6 81403.0 81547.2 82316.2 82430.0 7038.7 7279.8 7390.5 7651.2 7753.3 43367.8 44693.8 45156.3 45324.8 47481.3 56591.2 60342.7 64019.4 64465.0 66399.0 9543.6 9746.0 9790.6 9887.4 10131.3 10530.3 10698.8 10825.1 10942.9 10992.2 10269.1 10270.8 10560.1 10569.0 10670.8 9876.1 10292.5 10433.3 10536.6 10718.9 9508.5 9615.8 9818.3 10007.1 10143.2 8206.7 8314.6 8444.5 8751.7 8777.8 8881.9 9006.8 9096.3 9233.3 9428.8 15:52:38 INFO - PROCESS | 29049 | -------- Summary: end -------- 15:52:38 INFO - PROCESS | 29049 | 15:52:39 INFO - TEST-INFO | 29049: exit 0 15:52:39 INFO - TEST-OK | dromaeo_css | took 1120900ms 15:52:39 INFO - TEST-START | kraken 15:52:39 INFO - operating with platform_type : linux_ 15:52:39 INFO - Initialising browser for kraken test... 15:52:39 INFO - TEST-INFO | started process 29355 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyG1mbx/profile http://localhost:37089/getInfo.html) 15:52:43 INFO - PROCESS | 29355 | __metrics Screen width/height:1600/1200 15:52:43 INFO - PROCESS | 29355 | colorDepth:24 15:52:43 INFO - PROCESS | 29355 | Browser inner width/height: 1024/697 15:52:43 INFO - PROCESS | 29355 | __metrics 15:52:44 INFO - PROCESS | 29355 | 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" 15:52:44 INFO - PROCESS | 29355 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:52:45 INFO - PROCESS | 29355 | console.error: PushService: 15:52:45 INFO - PROCESS | 29355 | stateChangeProcessEnqueue: Error transitioning state 15:52:45 INFO - PROCESS | 29355 | UnknownError 15:52:45 INFO - TEST-INFO | 29355: exit 0 15:52:45 INFO - Browser initialized. 15:52:45 INFO - Running cycle 1/1 for kraken test... 15:52:45 INFO - TEST-INFO | started process 29436 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyG1mbx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:52:57 INFO - PROCESS | 29436 | RSS: Main: 175063040 15:52:57 INFO - PROCESS | 29436 | 15:53:00 INFO - PROCESS | 29436 | Cycle 1(1): loaded http://localhost:37089/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37089/tests/kraken/driver.html?testName=audio-beat-detection) 15:53:01 INFO - PROCESS | 29436 | RSS: Main: 237785088 15:53:01 INFO - PROCESS | 29436 | 15:53:04 INFO - PROCESS | 29436 | Cycle 1(1): loaded http://localhost:37089/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37089/tests/kraken/driver.html?testName=audio-dft) 15:53:04 INFO - PROCESS | 29436 | RSS: Main: 218312704 15:53:04 INFO - PROCESS | 29436 | 15:53:08 INFO - PROCESS | 29436 | Cycle 1(1): loaded http://localhost:37089/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37089/tests/kraken/driver.html?testName=audio-fft) 15:53:08 INFO - PROCESS | 29436 | RSS: Main: 300249088 15:53:08 INFO - PROCESS | 29436 | 15:53:11 INFO - PROCESS | 29436 | Cycle 1(1): loaded http://localhost:37089/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37089/tests/kraken/driver.html?testName=audio-oscillator) 15:53:11 INFO - PROCESS | 29436 | RSS: Main: 209690624 15:53:11 INFO - PROCESS | 29436 | 15:53:13 INFO - PROCESS | 29436 | Cycle 1(1): loaded http://localhost:37089/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37089/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:53:14 INFO - PROCESS | 29436 | RSS: Main: 213823488 15:53:14 INFO - PROCESS | 29436 | 15:53:17 INFO - PROCESS | 29436 | Cycle 1(1): loaded http://localhost:37089/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37089/tests/kraken/driver.html?testName=imaging-darkroom) 15:53:18 INFO - PROCESS | 29436 | RSS: Main: 250159104 15:53:18 INFO - PROCESS | 29436 | 15:53:21 INFO - PROCESS | 29436 | Cycle 1(1): loaded http://localhost:37089/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37089/tests/kraken/driver.html?testName=imaging-desaturate) 15:53:22 INFO - PROCESS | 29436 | RSS: Main: 249561088 15:53:22 INFO - PROCESS | 29436 | 15:53:25 INFO - PROCESS | 29436 | Cycle 1(1): loaded http://localhost:37089/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37089/tests/kraken/driver.html?testName=json-parse-financial) 15:53:25 INFO - PROCESS | 29436 | RSS: Main: 248590336 15:53:25 INFO - PROCESS | 29436 | 15:53:27 INFO - PROCESS | 29436 | Cycle 1(1): loaded http://localhost:37089/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37089/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:53:28 INFO - PROCESS | 29436 | RSS: Main: 211070976 15:53:28 INFO - PROCESS | 29436 | 15:53:30 INFO - PROCESS | 29436 | Cycle 1(1): loaded http://localhost:37089/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37089/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:53:30 INFO - PROCESS | 29436 | RSS: Main: 218419200 15:53:30 INFO - PROCESS | 29436 | 15:53:32 INFO - PROCESS | 29436 | Cycle 1(1): loaded http://localhost:37089/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37089/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:53:33 INFO - PROCESS | 29436 | RSS: Main: 222740480 15:53:33 INFO - PROCESS | 29436 | 15:53:36 INFO - PROCESS | 29436 | Cycle 1(1): loaded http://localhost:37089/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37089/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:53:37 INFO - PROCESS | 29436 | RSS: Main: 223461376 15:53:37 INFO - PROCESS | 29436 | 15:53:40 INFO - PROCESS | 29436 | Cycle 1(1): loaded http://localhost:37089/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37089/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:53:40 INFO - PROCESS | 29436 | RSS: Main: 222367744 15:53:40 INFO - PROCESS | 29436 | 15:53:42 INFO - PROCESS | 29436 | Cycle 1(1): loaded http://localhost:37089/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37089/tests/kraken/driver.html?testName=ai-astar) 15:53:42 INFO - PROCESS | 29436 | RSS: Main: 273657856 15:53:42 INFO - PROCESS | 29436 | 15:53:42 INFO - PROCESS | 29436 | __start_tp_report 15:53:42 INFO - PROCESS | 29436 | _x_x_mozilla_page_load 15:53:42 INFO - PROCESS | 29436 | _x_x_mozilla_page_load_details 15:53:42 INFO - PROCESS | 29436 | |i|pagename|runs| 15:53:42 INFO - PROCESS | 29436 | |0;ai-astar;116;116;115;116;114;116;113;114;114;115 15:53:42 INFO - PROCESS | 29436 | |1;audio-beat-detection;155;123;126;168;124;125;133;123;163;128 15:53:42 INFO - PROCESS | 29436 | |2;audio-dft;161;160;160;163;162;161;163;161;160;161 15:53:42 INFO - PROCESS | 29436 | |3;audio-fft;76;77;77;116;77;76;77;75;106;75 15:53:42 INFO - PROCESS | 29436 | |4;audio-oscillator;86;83;125;85;83;83;110;83;84;128 15:53:42 INFO - PROCESS | 29436 | |5;imaging-gaussian-blur;118;118;118;117;118;117;118;118;117;117 15:53:42 INFO - PROCESS | 29436 | |6;imaging-darkroom;148;148;146;146;146;146;146;146;146;146 15:53:42 INFO - PROCESS | 29436 | |7;imaging-desaturate;95;95;94;94;95;95;95;95;95;95 15:53:42 INFO - PROCESS | 29436 | |8;json-parse-financial;65;63;64;63;64;66;64;66;65;65 15:53:42 INFO - PROCESS | 29436 | |9;json-stringify-tinderbox;67;66;65;65;67;66;66;66;66;66 15:53:42 INFO - PROCESS | 29436 | |10;stanford-crypto-aes;83;82;86;82;87;83;92;82;83;83 15:53:42 INFO - PROCESS | 29436 | |11;stanford-crypto-ccm;138;142;133;130;133;136;133;141;174;137 15:53:42 INFO - PROCESS | 29436 | |12;stanford-crypto-pbkdf2;173;176;179;172;174;176;174;172;174;176 15:53:42 INFO - PROCESS | 29436 | |13;stanford-crypto-sha256-iterative;69;69;75;69;68;70;69;69;68;69 15:53:42 INFO - PROCESS | 29436 | __end_tp_report 15:53:42 INFO - PROCESS | 29436 | __start_cc_report 15:53:42 INFO - PROCESS | 29436 | _x_x_mozilla_cycle_collect,1954 15:53:42 INFO - PROCESS | 29436 | __end_cc_report 15:53:42 INFO - PROCESS | 29436 | __startTimestamp1474152822700__endTimestamp 15:53:42 INFO - PROCESS | 29436 | 15:53:42 INFO - PROCESS | 29436 | ------- Summary: start ------- 15:53:42 INFO - PROCESS | 29436 | Number of tests: 14 15:53:42 INFO - PROCESS | 29436 | 15:53:42 INFO - PROCESS | 29436 | [#0] ai-astar Cycles:10 Average:114.90 Median:115.50 stddev:1.10 (1.0%) stddev-sans-first:1.09 15:53:42 INFO - PROCESS | 29436 | Values: 116.0 116.0 115.0 116.0 114.0 116.0 113.0 114.0 114.0 115.0 15:53:42 INFO - PROCESS | 29436 | 15:53:42 INFO - PROCESS | 29436 | [#1] audio-beat-detection Cycles:10 Average:136.80 Median:130.50 stddev:17.90 (13.7%) stddev-sans-first:17.73 15:53:42 INFO - PROCESS | 29436 | Values: 155.0 123.0 126.0 168.0 124.0 125.0 133.0 123.0 163.0 128.0 15:53:42 INFO - PROCESS | 29436 | 15:53:42 INFO - PROCESS | 29436 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 15:53:42 INFO - PROCESS | 29436 | Values: 161.0 160.0 160.0 163.0 162.0 161.0 163.0 161.0 160.0 161.0 15:53:42 INFO - PROCESS | 29436 | 15:53:42 INFO - PROCESS | 29436 | [#3] audio-fft Cycles:10 Average:83.20 Median:76.50 stddev:14.86 (19.4%) stddev-sans-first:15.53 15:53:42 INFO - PROCESS | 29436 | Values: 76.0 77.0 77.0 116.0 77.0 76.0 77.0 75.0 106.0 75.0 15:53:42 INFO - PROCESS | 29436 | 15:53:42 INFO - PROCESS | 29436 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:83.00 stddev:18.54 (22.3%) stddev-sans-first:19.37 15:53:42 INFO - PROCESS | 29436 | Values: 86.0 83.0 125.0 85.0 83.0 83.0 110.0 83.0 84.0 128.0 15:53:42 INFO - PROCESS | 29436 | 15:53:42 INFO - PROCESS | 29436 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 15:53:42 INFO - PROCESS | 29436 | Values: 118.0 118.0 118.0 117.0 118.0 117.0 118.0 118.0 117.0 117.0 15:53:42 INFO - PROCESS | 29436 | 15:53:42 INFO - PROCESS | 29436 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.84 (0.6%) stddev-sans-first:0.67 15:53:42 INFO - PROCESS | 29436 | Values: 148.0 148.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 15:53:42 INFO - PROCESS | 29436 | 15:53:42 INFO - PROCESS | 29436 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 15:53:42 INFO - PROCESS | 29436 | Values: 95.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 15:53:42 INFO - PROCESS | 29436 | 15:53:42 INFO - PROCESS | 29436 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:65.00 stddev:1.08 (1.7%) stddev-sans-first:1.13 15:53:42 INFO - PROCESS | 29436 | Values: 65.0 63.0 64.0 63.0 64.0 66.0 64.0 66.0 65.0 65.0 15:53:42 INFO - PROCESS | 29436 | 15:53:42 INFO - PROCESS | 29436 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 15:53:42 INFO - PROCESS | 29436 | Values: 67.0 66.0 65.0 65.0 67.0 66.0 66.0 66.0 66.0 66.0 15:53:42 INFO - PROCESS | 29436 | 15:53:42 INFO - PROCESS | 29436 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:83.00 stddev:3.20 (3.9%) stddev-sans-first:3.36 15:53:42 INFO - PROCESS | 29436 | Values: 83.0 82.0 86.0 82.0 87.0 83.0 92.0 82.0 83.0 83.0 15:53:42 INFO - PROCESS | 29436 | 15:53:42 INFO - PROCESS | 29436 | [#11] stanford-crypto-ccm Cycles:10 Average:139.70 Median:137.50 stddev:12.63 (9.2%) stddev-sans-first:13.38 15:53:42 INFO - PROCESS | 29436 | Values: 138.0 142.0 133.0 130.0 133.0 136.0 133.0 141.0 174.0 137.0 15:53:42 INFO - PROCESS | 29436 | 15:53:42 INFO - PROCESS | 29436 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.60 Median:175.00 stddev:2.17 (1.2%) stddev-sans-first:2.22 15:53:42 INFO - PROCESS | 29436 | Values: 173.0 176.0 179.0 172.0 174.0 176.0 174.0 172.0 174.0 176.0 15:53:42 INFO - PROCESS | 29436 | 15:53:42 INFO - PROCESS | 29436 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.00 stddev:2.01 (2.9%) stddev-sans-first:2.13 15:53:42 INFO - PROCESS | 29436 | Values: 69.0 69.0 75.0 69.0 68.0 70.0 69.0 69.0 68.0 69.0 15:53:42 INFO - PROCESS | 29436 | -------- Summary: end -------- 15:53:42 INFO - PROCESS | 29436 | 15:53:43 INFO - TEST-INFO | 29436: exit 0 15:53:43 INFO - TEST-OK | kraken | took 64940ms 15:53:43 INFO - SUITE-END | took 1185s 15:53:44 INFO - Completed test suite (00:19:46) 15:53:44 INFO - javascript benchmark 15:53:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2528.1657053172453, 2557.8721063946796, 2584.05681926097, 2589.520938626354, 2598.896044158234, 4527.932081018787, 4604.907901841962, 4634.258518637014, 4646.860594182176, 4652.348671186037, 4609.792559334838, 4629.421322334708, 4633.698809577383, 4666.626669866411, 4687.20317546018, 4243.257429949762, 4263.8081286342185, 4289.871303860889, 4291.0988692374485, 4363.454568178978, 4306.892327691817, 4362.0621566363225, 4383.189110014641, 4399.296112621981, 4417.293233082707, 4191.601797829201, 4253.829846806124, 4344.587264209895, 4349.043210493686, 4354.477462704464, 4275.0, 4294.355846623001, 4294.935575966332, 4295.656347492193, 4297.183535128315, 4262.7655478948645, 4267.850625228133, 4268.295731204347, 4268.765217913014, 4277.593628605277, 4527.388802511652, 4574.61115805157, 4597.37935378723, 4628.236341003731, 4634.073185362941, 4889.095517329305, 4891.0, 4896.779644915988, 4938.086454005985, 4948.282499037619, 4892.437369702494, 4897.179046609857, 4904.239842824368, 4928.531789479994, 4964.05682920244, 4502.144592527409, 4508.143452744033, 4552.271636538138, 4603.723776573383, 4647.302904564309, 4977.875553111129, 4990.525900039491, 4992.600591952635, 4993.325901003391, 4997.200447928314, 4778.713277203379, 4809.95190048102, 4814.253790662453, 4819.855404337875, 4823.807047718122, 4882.292067650171, 4937.703737775745, 4998.700077995332, 5005.224190250517, 5059.241113832954, 4966.950330496648, 4967.031428871335, 4971.825986090469, 4975.303457515951, 5022.84931452057, 4933.703977761345, 4952.207646776498, 4955.157623204064, 4961.578265847371, 5006.799728010911, 4057.229126465962, 4115.259253334369, 4119.526254480713, 4132.648724858421, 4155.1897380010605, 3635.2547727715755, 3645.398509245998, 3680.0431887709387, 3690.206605579813, 3701.8149092545264, 4154.771487568152, 4194.224068547329, 4194.706370554032, 4241.130568233505, 4242.957570424318, 4825.203841366206, 4980.203167493184, 4981.9252711209365, 4983.800647974041, 5033.6224783141415, 4079.8164082616354, 4183.728057676241, 4233.682473814476, 4237.87286381409, 4279.122779830127, 4495.595396414338, 4496.797644106023, 4542.500324964251, 4550.385697930737, 4555.931661025087, 4717.599004084691, 4718.787654555554, 4722.52774722525, 4723.858284251478, 4778.880527986828, 4857.0528746894015, 4920.114379411741, 4957.801687932442, 5015.724135172601, 5019.0463811875625, 4674.0, 4674.135284972291, 4677.976610116928, 4734.455537613218, 4739.265413860857, 4886.92669609949, 4887.462379138363, 4891.584215341736, 4894.437139728977, 4954.5788607968725, 4807.062622788522, 4878.926816097691, 4905.583025442877, 4948.1835497142565, 5022.045811295842, 4774.30772537987, 4843.1524483216, 4860.635452341018, 4864.781084851119, 4920.40955085392, 4859.975700121477, 4863.10032643962, 4874.390701162355, 4875.512448755097, 4929.531694489017, 4631.444226692818, 4794.856154315376, 4799.352087468287, 4809.879753006203, 4872.585830204473, 4760.666753327372, 4810.6632535722165, 4813.03739252158, 4861.052094841472, 4862.95137048625, 4746.78639461232, 4754.809807607657, 4783.425988881357, 4785.3779008730035, 4815.446223684321], "value": 4546.580992490841, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.4707257496516, 550.5182964905707, 562.6511562831045, 563.8703098287393, 564.3848205456052, 28549.0, 31469.527957080605, 31537.68462315379, 31550.684493155062, 31559.684403155963, 31983.840080799622, 32714.182145446317, 44459.77770111153, 45880.31179532301, 45962.31056534155, 7567.962160189205, 7679.385649148055, 7695.538267703956, 7697.769066927973, 7701.845963080735, 7623.733169339074, 7716.189800070968, 7723.343515801135, 7724.382049436032, 7727.343175830061, 7762.883556746625, 7799.181085985975, 7802.024746906637, 7803.687852485894, 7804.336631386339, 7691.153973062958, 7739.61301934901, 7750.379969602418, 7750.961245193795, 7751.689932402697, 7450.441216908754, 7497.625118744041, 7515.323620874093, 7516.962415187943, 7517.849643007109, 39223.8038809807, 39478.40782388266, 39772.403413948814, 39805.402918956235, 40072.198556028714, 2927.077970439305, 2988.417258634567, 3036.149878034154, 3125.890593829205, 3196.2329041029984, 29260.70739292601, 29533.261668458246, 29562.556561651592, 29987.400251995055, 31016.0, 3369.932601347984, 3463.9134021649406, 3498.405271103893, 3520.77114987525, 3571.94642080369, 260891.0, 260902.0, 261401.0, 261935.0, 262172.689136555, 31759.52360714591, 32865.178370540925, 32907.17732056718, 55880.6029849257, 56372.71813640906, 34236.0, 34320.82839585786, 34418.82790586081, 34466.82766586151, 34474.482882756776, 13553.728925421436, 13705.520306789414, 13719.0, 13720.519781807589, 13742.244176570384, 11129.777404451866, 11191.2725672831, 11194.160437967184, 11220.046296064762, 11307.717307067389, 7668.348190403878, 7798.649060792278, 7854.646540905673, 7890.566018869017, 7922.247386498273, 3091.536269559584, 3097.396007778507, 3097.9535306970415, 3111.968880311213, 3149.9212519686735, 836.1554829622125, 848.6138806842995, 895.9910400895908, 928.4475736936512, 970.8058388322364, 26314.473710525683, 26422.6036609451, 27081.32296692559, 27141.86429067842, 27394.315142121206, 794.3168874767695, 965.5510187762724, 992.2062350119875, 994.0159242350165, 1004.1314263162312, 13589.320533973261, 14668.119912805267, 14759.77860332096, 14870.107793532423, 14936.32786524609, 385434.0, 390502.0, 390864.0, 392384.0, 392386.0, 49003.509964899895, 49637.75181124071, 49686.50313496891, 49774.0, 49781.0, 1077.1167642533048, 1117.8714447838602, 1161.4947497838468, 1182.810750279951, 1226.8957138643316, 27129.321766955985, 28852.0, 29176.562351565168, 29427.871594710643, 29667.55498667565, 42679.78660106679, 42877.0, 43010.35484467673, 43118.35322470103, 43151.0, 236425.0, 236592.0, 236838.0, 237252.0, 237859.0, 24801.25596232116, 25438.109666162334, 25485.872570637028, 25576.74423255818, 26739.732602673725, 40986.59013409947, 41236.58763412447, 41257.96855078647, 41319.58680413158, 42053.0, 35238.647613523535, 35409.783624649455, 35518.64481355153, 35615.0, 35767.46348804718, 34874.30251395009, 35679.0, 35765.28469430649, 35796.284074318886, 36053.0, 34476.482852757734, 34836.82581587177, 35018.29963400667, 35163.82418087996, 35171.47242791309, 30185.0, 32045.67954320427, 32461.67538324681, 32461.837690811393, 32503.837480812446, 24383.878080609484, 24502.754972450046, 24576.084783043105, 25229.495410092062, 25272.62091068672], "value": 16082.007509970028, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.1233130853707, 361.1765175400087, 366.78543052314393, 373.24976796638765, 391.843262694922, 12345.876541234586, 15610.0, 15802.604934876634, 16908.323667053304, 17028.659426811486, 16509.752353714674, 16762.161891905416, 17099.572510687238, 17215.139243037862, 17242.913785431087, 4820.445648750386, 4884.169691152495, 4915.115279249733, 5068.974655126728, 5140.151949755811, 3689.1883785567265, 3881.3789793633023, 4938.580220681229, 5020.0, 5023.623228257877, 5734.254546908896, 5999.280086389639, 6024.427679370475, 6112.602680825732, 6130.816075517741, 5178.741062946875, 5427.592930530226, 5463.153211252262, 6108.511319094462, 6116.266048074215, 5343.171808369709, 5353.9196912046355, 5359.758810853521, 5364.785408583652, 5365.490278423544, 12477.688057798538, 12598.433070511848, 12896.613101606967, 12938.935305323508, 12995.870041299655, 1802.7295905614133, 2108.2726459371493, 2133.4133113393787, 2314.132200424841, 2342.5314937012495, 8850.424722393089, 9101.681441149594, 9700.563474643657, 9984.850227246598, 13669.453221871114, 1708.8376604222578, 1745.9912700436544, 1751.5445984044113, 1765.3027054313602, 1802.1349752119056, 67329.3267067328, 70923.64538177276, 72362.78376851596, 72904.0, 74763.62618186929, 8459.788505287293, 9080.8637870432, 9080.8637870432, 9085.68200113006, 10080.647177348905, 12082.637520874388, 12163.331016793984, 12183.512659493521, 12186.695332616755, 12191.268523888595, 6980.895286570705, 7084.681189346492, 7175.390091842148, 7363.226861179606, 7367.447441441914, 7084.43324534036, 7139.750108746169, 7197.1363436387965, 7361.227071157558, 7396.963015184997, 3573.160307327776, 3618.9819050905103, 3818.770873747584, 3872.186840763471, 3890.8054597270025, 1772.831580999803, 1796.8472679822362, 1850.80566540514, 1855.879367841086, 1863.7419741674316, 798.9480683755653, 813.9145389733993, 842.8735689646479, 862.9697960571475, 906.7506435730227, 16190.271437785328, 16406.507804765875, 16925.830741692673, 17527.561810954827, 17633.647327053386, 846.9280111190494, 861.5476874640864, 880.7798050487378, 885.3138817416425, 899.2266650680409, 9153.267738580898, 9513.904860951441, 9722.659706910224, 9788.363756355815, 9969.35199212049, 375662.0, 375976.0, 384897.8122625247, 386001.0, 386681.0, 79183.0, 80414.59792700999, 82132.58933705294, 83748.0, 84423.15576844275, 901.2069378946354, 920.0431551186824, 943.9244860411151, 945.0313428735464, 945.9668911588061, 14584.489542866373, 14715.92642036783, 15078.396864125312, 15152.848471515144, 15414.075155490706, 25558.0, 25846.22461326163, 35790.28419431545, 37640.62359376481, 37650.246995060494, 46556.7672161637, 47324.2901356473, 47918.52081479141, 55087.0, 56115.71942140263, 7287.307705767944, 7637.465377423527, 7660.3488703460835, 7819.609019549113, 7948.330850521455, 9008.0, 11799.646010619696, 11981.400929953641, 12181.939090304491, 12283.447244874182, 10199.490025498548, 10290.279680422298, 10352.792944141225, 10763.192760543147, 10893.400862952614, 10328.380297182193, 10655.094316983143, 10719.732006699584, 10756.0, 11000.834987475355, 10074.798504029732, 10512.78974420492, 10537.15702743794, 10736.463176841284, 10753.58044440026, 7395.630218489162, 7526.661300241392, 7602.657880395285, 7858.44990850635, 7887.64505597238, 10160.441175735405, 10212.234082443698, 10347.172226222036, 10433.634822781167, 10972.506237219184], "value": 8046.31300404144, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1222.1750318534998, 1364.8362196536411, 1385.0097180515932, 1477.5271912987848, 1706.0616660836538, 6808.727650893965, 7568.62156892156, 7808.492447990877, 7885.1326354101, 8147.837043259146, 7936.563489008102, 8010.719624813133, 8016.478928869619, 8026.8394632107465, 8029.5182289062695, 2182.476205710626, 2222.7777222277805, 2223.444138965259, 2223.455253462904, 2224.421650370899, 2169.457635591102, 2195.418214173237, 2228.3983324502456, 2233.687283780272, 2233.8771367574777, 2171.207509259117, 2177.967330490044, 2202.90086946087, 2204.481946742514, 2216.4569680428317, 2151.268568686646, 2158.4064382294996, 2160.4058883807, 2161.556880839424, 2161.6217161996747, 2158.3740715192575, 2203.4711669199437, 2204.4599073227, 2215.1471683401846, 2218.889055547232, 7959.164287749819, 7975.760727178136, 8019.839603207904, 8024.839503209962, 8027.317677997377, 4348.869533913988, 4514.300283456069, 4535.206338890681, 4574.382458368144, 4577.169132347054, 2757.352022274764, 2817.1266907258814, 2866.5270230411957, 2880.510313246753, 2890.913272601825, 956.7608097975506, 961.1637875048682, 970.9804705059659, 978.7406337320616, 978.8091322192175, 10891.237613367068, 10936.12510999126, 10982.560697572168, 11036.944815275952, 11083.833742493869, 4040.5151381834366, 4091.672666186698, 4186.958130418718, 4198.958010419857, 4212.957870421318, 8651.351148663749, 8658.051938313829, 8661.263792577702, 8661.870071948926, 8662.177093176138, 4516.07420478801, 4534.6372290216705, 4544.886377840514, 4545.022820093695, 4545.522720114406, 3578.3916734154736, 3650.9634903651154, 3793.7723736575895, 4156.106437115974, 4157.958420415817, 3168.730657894059, 3493.318802833474, 3523.5419395478425, 3541.9291614167573, 3550.5916819565564, 1039.1738567838586, 1063.6064656077301, 1068.957241710323, 1080.5785743560018, 1089.0688461365576, 657.3360905485495, 768.047620950018, 781.2929298984428, 786.4573444323398, 797.4417907464798, 4879.072976134523, 4994.051130285234, 4999.825076091912, 5000.524950129732, 5092.490750924952, 408.60977766233174, 408.9100397912454, 410.2512913932086, 412.65955586641144, 419.5804195804196, 3305.1571849178304, 3423.7945723256685, 3462.567179102612, 3472.340255351475, 3492.877749278763, 9237.261019118589, 9449.0, 9527.475988820543, 9541.141297283139, 9619.134277915022, 9415.670451534163, 9427.292953028551, 9447.858282125773, 9474.763130921781, 9498.430094194371, 7074.151101867706, 7119.964400177966, 7136.0, 7142.250063743232, 7149.642517874189, 4797.928031079607, 4819.349387832598, 4946.579540739078, 4951.944942848678, 5001.64988450805, 8571.314294856273, 8618.05201427855, 8746.125387461458, 8758.255548278214, 8768.561571921506, 8780.824383512167, 8867.91132088671, 8887.422317549339, 8979.955100224457, 8996.460212387277, 6214.8135555933395, 6256.311805701278, 6256.718447669775, 6265.4361107500545, 6270.592411493239, 7000.299970003162, 7224.2414546473965, 7278.927210728037, 7280.490365674564, 7423.406127509894, 6481.902771458526, 6520.869582608227, 6547.312532184243, 6602.0, 6879.415249703631, 6518.282988871315, 6647.534672572873, 6676.0987266718375, 6761.357671021246, 6894.724211031503, 6130.540209484396, 6208.627482351073, 6244.063390491463, 6281.685915704288, 6283.96858015707, 4414.9558504414545, 4450.354698568754, 4536.56902594253, 4573.222552166207, 4628.421447319085, 4368.934465982949, 4571.908561828678, 4587.885302867455, 4610.492845787028, 4664.533546645308], "value": 3976.08286058257, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.32054236882277, 305.7721997112152, 309.25161110113515, 311.72256691544527, 314.0938392736953, 4780.8565743027675, 4820.132376172288, 4823.5417635324675, 4827.44484384295, 4850.223964165734, 4706.788194531246, 4770.236762118062, 4773.0, 4776.68951518152, 4789.209780386241, 3607.621199774025, 3728.7203459740495, 3737.588865224837, 3740.9625903740884, 3759.248150369923, 3652.8904132875923, 3749.2501499700033, 3782.73520853539, 3791.5450145982522, 3828.157805282833, 3734.916874106506, 3736.1967177056927, 3738.7943663098517, 3748.269087527933, 3750.1749615084636, 3528.188516641161, 3701.8519259229597, 3742.6631603155847, 3749.2501499700033, 3762.5673047599466, 3262.559554460165, 3266.836658167082, 3268.0, 3269.7874638148683, 3271.4765637497885, 4619.16854966106, 4619.260918253063, 4623.514530974267, 4629.884252893705, 4640.76796160194, 4207.389928460356, 4228.577142285778, 4252.425922500453, 4254.0, 4254.255505286563, 4717.292406139072, 4928.137575924199, 4937.851864444036, 4968.056069346849, 5006.0, 3568.3398571264397, 3575.6960658344074, 3576.8211589420685, 3577.3560759063357, 3579.818659842246, 5141.742912854343, 5168.5606723428555, 5179.430262671103, 5228.660137091077, 5251.422343542207, 3538.7522873398616, 3593.82030898454, 3623.329684008414, 3676.411774116182, 3685.2076803486843, 3671.30245253401, 3674.65090816372, 3676.5036720042986, 3690.4648825920626, 3698.6486283802997, 4169.708120431601, 4170.124273902454, 4183.644390226804, 4195.706300558993, 4203.726757760797, 4890.364252647133, 4891.853244402673, 4927.60579153674, 4931.605471562267, 4934.358533390708, 1227.864934857165, 1273.81529678198, 1278.3672082319126, 1285.1774864086992, 1285.8456985161654, 802.3821657323945, 816.5141740664295, 819.9344052475788, 831.4595512916652, 839.7942504086416, 4123.402106694512, 4145.461090058273, 4233.5131459881895, 4295.591918767712, 4306.569343065668, 5102.872428189325, 5117.283580298761, 5122.692638441706, 5130.4356520782685, 5134.87162820925, 4320.632746216544, 4324.84286470878, 4325.891852703708, 4327.221100201994, 4334.306510958231, 2614.764671179565, 2663.3741070848337, 2688.2338533518246, 2697.2717366311376, 2708.7968402369506, 4793.18515852306, 4798.520147985174, 4808.975955120202, 4811.230203167476, 4813.422389313305, 5196.220566914993, 5200.271961925334, 5227.869303267373, 5229.843104706865, 5230.293910322134, 4583.702059366131, 4837.201861692782, 4867.221244600847, 4870.853874383774, 4871.8294859679745, 5128.615353848401, 5132.5628823929355, 5135.226977432145, 5147.974260128675, 5169.172932330809, 4867.659263851638, 5048.813528820798, 5059.392872855134, 5074.441811400817, 5097.93533618885, 4834.0, 4846.0, 4853.927191092066, 4870.586000190024, 4875.585575226004, 3634.909127271839, 3665.1020499977676, 3668.4313931340685, 3681.337359275249, 3704.8332825023476, 5119.692818430906, 5150.356205474316, 5151.304573882478, 5166.509181627739, 5186.4035635902355, 4731.526847315241, 4940.308356830118, 4945.381827271591, 4947.1448206922405, 4977.477364876636, 4943.541655211793, 4950.727709975986, 4960.23116416956, 4960.900781984412, 5000.549730632037, 4860.222364421676, 4882.438519570295, 4886.218205087169, 4891.828785992473, 4901.3383193268455, 4726.881827954328, 4737.763111844325, 4871.683340582851, 4944.653874228769, 4989.351384320015, 4793.520647935178, 4901.50984901507, 4920.901581968412, 4925.408950925768, 4935.481774413634], "value": 3750.6204950434585, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.7898708997035, 572.8338781753289, 626.3454689849107, 680.8706345794299, 716.0548076538969, 12437.0, 13058.673533161676, 13149.079564430494, 13154.671133221675, 13159.473621055145, 12911.418986145622, 12993.0, 13029.153105048164, 13030.15304005239, 13031.348432578381, 615.3815415507408, 630.9558330916838, 745.7650839985414, 759.6163937211701, 776.1501156233915, 746.9141048779405, 768.3238749900108, 769.5421224371518, 773.8374941262342, 775.5346791924857, 805.6213579617599, 809.6437567470294, 811.1766556944676, 811.6591031766643, 812.3744716568239, 638.773235501395, 655.3315618069543, 780.3484090784202, 807.7778610881995, 808.0505406147753, 589.9380565040652, 591.0189086117068, 591.9230500035011, 592.170960655082, 592.8458600763789, 12224.572139975147, 12240.081993850497, 12266.8959793619, 12278.570250041295, 12294.385280735927, 11234.382108984002, 11478.0, 11538.884611153864, 11567.53729850805, 12218.389080545938, 10459.947700261526, 10600.946995264974, 10787.244892857503, 10848.349099054081, 10897.782044359148, 3926.980365098185, 3943.2507823513442, 3945.842166313344, 3981.7411868228473, 4026.375911733686, 52951.735241323935, 54340.18489722657, 54653.726731366485, 60444.0, 64468.3553164467, 10003.099721025143, 10379.532921018572, 10419.583216671248, 10423.218258630633, 10592.682219533272, 18139.54651133732, 18433.72349414733, 18761.624767504847, 18777.15502802377, 18789.90605046966, 6902.861942761117, 6979.720811167598, 7030.050943122716, 7114.71541138359, 7212.567245965154, 3541.5395998520025, 3648.872289469856, 3705.8517659293866, 3716.535433070866, 3764.8494060237285, 2919.6350456192977, 3055.984720076385, 3058.2507285714696, 3068.3403068340413, 3075.538669199593, 511.27654369068097, 520.7084032941489, 529.4811085136588, 531.0971348707136, 534.4762133109574, 446.63822303933915, 450.94363204599426, 465.14181335436064, 466.55677106748726, 474.3513567042965, 7595.810104747426, 7833.843323133619, 7923.881141782877, 7924.920750792534, 7975.082865470429, 441.8342575446951, 468.32093464476645, 508.6083715539088, 517.6505858545466, 519.3508114856429, 3548.8048157351077, 3575.5530558680166, 3579.3736096183065, 3605.963940360615, 3650.251698401821, 103980.0, 104463.0, 105195.0, 107040.0, 107931.0, 52066.21900671493, 53726.46273537293, 56775.71612141913, 88910.0, 92124.0, 77453.61273193598, 81403.0, 81547.18452815515, 82316.17683823204, 82430.0, 7038.718451261892, 7279.781606551812, 7390.5196162249285, 7651.234876512304, 7753.263439973193, 43367.78316108399, 44693.77653111714, 45156.32265516085, 45324.77337613291, 47481.28778068263, 56591.151132732215, 60342.69828651004, 64019.359806403205, 64465.0, 66399.0, 9543.570539325608, 9745.951270243604, 9790.608375665179, 9887.357321774061, 10131.341462804894, 10530.262881598215, 10698.786024279627, 10825.13398928068, 10942.890571094187, 10992.17558683118, 10269.075783179549, 10270.845937311096, 10560.102391296827, 10569.048785609331, 10670.786584268117, 9876.111149996535, 10292.485375731034, 10433.348328085109, 10536.57853685844, 10718.946405268236, 9508.524573771421, 9615.759606009906, 9818.312718109664, 10007.149392301735, 10143.188544916537, 8206.671733130608, 8314.584270786558, 8444.535550544779, 8751.737447876574, 8777.780555486164, 8881.911180888108, 9006.774830629287, 9096.27229821626, 9233.302582110757, 9428.764280893032], "value": 6226.311100654826, "unit": "score"}], "name": "dromaeo_css", "value": 6159.941954878158, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 115.0, 116.0, 114.0, 116.0, 113.0, 114.0, 114.0, 115.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 123.0, 126.0, 168.0, 124.0, 125.0, 133.0, 123.0, 163.0, 128.0], "value": 136.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 163.0, 162.0, 161.0, 163.0, 161.0, 160.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 116.0, 77.0, 76.0, 77.0, 75.0, 106.0, 75.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 125.0, 85.0, 83.0, 83.0, 110.0, 83.0, 84.0, 128.0], "value": 95.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 146.0, 146.0, 146.0, 146.0, 146.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, 94.0, 95.0, 95.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, 63.0, 64.0, 63.0, 64.0, 66.0, 64.0, 66.0, 65.0, 65.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 65.0, 65.0, 67.0, 66.0, 66.0, 66.0, 66.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 86.0, 82.0, 87.0, 83.0, 92.0, 82.0, 83.0, 83.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 142.0, 133.0, 130.0, 133.0, 136.0, 133.0, 141.0, 174.0, 137.0], "value": 139.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 176.0, 179.0, 172.0, 174.0, 176.0, 174.0, 172.0, 174.0, 176.0], "value": 174.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 75.0, 69.0, 68.0, 70.0, 69.0, 69.0, 68.0, 69.0], "value": 69.5, "unit": "score"}], "name": "kraken", "value": 1548.4999999999998, "alertThreshold": 2.0}]} 15:53:44 INFO - Return code: 0 15:53:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:53:44 INFO - # TBPL SUCCESS # 15:53:44 INFO - Running post-action listener: _resource_record_post_action 15:53:44 INFO - [mozharness: 2016-09-17 22:53:44.526953Z] Finished run-tests step (success) 15:53:44 INFO - Running post-run listener: _resource_record_post_run 15:53:44 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 385552384; Read time: 16; Write time: 323540 15:53:44 INFO - TinderboxPrint: CPU usage
13.0% 15:53:44 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 15:53:44 INFO - TinderboxPrint: I/O write bytes / time
385,552,384 / 323,540 15:53:44 INFO - TinderboxPrint: CPU idle
8,338.9 (86.9%) 15:53:44 INFO - TinderboxPrint: CPU user
1,199.6 (12.5%) 15:53:44 INFO - TinderboxPrint: Swap in / out
0 / 0 15:53:44 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99500032; Read time: 0; Write time: 108920 15:53:44 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 286052352; Read time: 0; Write time: 214620 15:53:45 INFO - Running post-run listener: _upload_blobber_files 15:53:45 INFO - Blob upload gear active. 15:53:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:53:45 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 15:53:45 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'] 15:53:45 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 15:53:45 INFO - (blobuploader) - INFO - Open directory for files ... 15:53:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:53:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:53:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:53:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:53:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:53:46 INFO - (blobuploader) - INFO - Done attempting. 15:53:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:53:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:53:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:53:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:53:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:53:50 INFO - (blobuploader) - INFO - Done attempting. 15:53:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:53:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:53:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:53:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:53:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:53:50 INFO - (blobuploader) - INFO - Done attempting. 15:53:50 INFO - (blobuploader) - INFO - Iteration through files over. 15:53:50 INFO - Return code: 0 15:53:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:53:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:53:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0cd67dee0f017f22b49202e244c9e6f864d219e06ea54a957ded1c31bb310b9d58c3de5b144079b0de287e6375ac033084cd88b02c116d929555add34e5d5b39", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b91d1f103ad2a274997822b1e9c1a9c1cf436fad73be1d8f877e90b17661d3b271cf754983f4f163ab2639a3c79e42b32b2eb3afcf6515e6c394e1c00b8187e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7285e0c68bbb25b963cbc07018790eb014d9b1a2d013e6100496f3936697213154b8851cc3143275067fda6125fb396caadc6003767f3824300c816463ccddf4"} 15:53:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:53:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:53:50 INFO - Contents: 15:53:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0cd67dee0f017f22b49202e244c9e6f864d219e06ea54a957ded1c31bb310b9d58c3de5b144079b0de287e6375ac033084cd88b02c116d929555add34e5d5b39", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b91d1f103ad2a274997822b1e9c1a9c1cf436fad73be1d8f877e90b17661d3b271cf754983f4f163ab2639a3c79e42b32b2eb3afcf6515e6c394e1c00b8187e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7285e0c68bbb25b963cbc07018790eb014d9b1a2d013e6100496f3936697213154b8851cc3143275067fda6125fb396caadc6003767f3824300c816463ccddf4"} 15:53:50 INFO - Running post-run listener: copy_logs_to_upload_dir 15:53:50 INFO - Copying logs to upload dir... 15:53:50 INFO - mkdir: /builds/slave/test/build/upload/logs 15:53:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.082492 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-09-17 15:53:50.665239) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-17 15:53:50.669106) ========= 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=920470bf432669ad7e3a5387000001ca-1474151583.365078-923415544 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/0cd67dee0f017f22b49202e244c9e6f864d219e06ea54a957ded1c31bb310b9d58c3de5b144079b0de287e6375ac033084cd88b02c116d929555add34e5d5b39", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b91d1f103ad2a274997822b1e9c1a9c1cf436fad73be1d8f877e90b17661d3b271cf754983f4f163ab2639a3c79e42b32b2eb3afcf6515e6c394e1c00b8187e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7285e0c68bbb25b963cbc07018790eb014d9b1a2d013e6100496f3936697213154b8851cc3143275067fda6125fb396caadc6003767f3824300c816463ccddf4"} build_url:https://queue.taskcluster.net/v1/task/AwgkQsfLSCe89EXhAwZE3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011397 build_url: 'https://queue.taskcluster.net/v1/task/AwgkQsfLSCe89EXhAwZE3Q/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/0cd67dee0f017f22b49202e244c9e6f864d219e06ea54a957ded1c31bb310b9d58c3de5b144079b0de287e6375ac033084cd88b02c116d929555add34e5d5b39", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b91d1f103ad2a274997822b1e9c1a9c1cf436fad73be1d8f877e90b17661d3b271cf754983f4f163ab2639a3c79e42b32b2eb3afcf6515e6c394e1c00b8187e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7285e0c68bbb25b963cbc07018790eb014d9b1a2d013e6100496f3936697213154b8851cc3143275067fda6125fb396caadc6003767f3824300c816463ccddf4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-17 15:53:50.694830) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 15:53:50.695190) ========= 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=920470bf432669ad7e3a5387000001ca-1474151583.365078-923415544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004404 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 15:53:50.778540) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-17 15:53:50.778872) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-17 15:53:50.779183) ========= ========= Total master_lag: 0.16 =========